builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1486476849.51 results: success (0) revision: 6d27535f4fe912068e0a0ac5854f7f39e94964a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:09.505382) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:09.505845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:09.506126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:09.522282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:09.522557) ========= 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=af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-07 06:14:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-02-07 06:14:09 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118445 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:09.654201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:09.654518) ========= 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=af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013942 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:09.703308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 06:14:09.703641) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d27535f4fe912068e0a0ac5854f7f39e94964a5 --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 6d27535f4fe912068e0a0ac5854f7f39e94964a5 --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=af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-07 06:14:10,111 truncating revision to first 12 chars 2017-02-07 06:14:10,111 Setting DEBUG logging. 2017-02-07 06:14:10,111 attempt 1/10 2017-02-07 06:14:10,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d27535f4fe9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 06:14:11,178 unpacking tar archive at: mozilla-central-6d27535f4fe9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.390332 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 06:14:11.106909) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:11.107256) ========= script_repo_revision: 6d27535f4fe912068e0a0ac5854f7f39e94964a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:11.107686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:11.107961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 06:14:11.115378) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-02-07 06:14:11.115678) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:11 INFO - MultiFileLogger online at 20170207 06:14:11 in /builds/slave/test 06:14:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:14:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:11 INFO - {'append_to_log': False, 06:14:11 INFO - 'base_work_dir': '/builds/slave/test', 06:14:11 INFO - 'blob_upload_branch': 'Firefox', 06:14:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:11 INFO - 'branch': 'Firefox', 06:14:11 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:11 INFO - 'config_files': ('talos/linux_config.py',), 06:14:11 INFO - 'default_actions': ('clobber', 06:14:11 INFO - 'read-buildbot-config', 06:14:11 INFO - 'download-and-extract', 06:14:11 INFO - 'populate-webroot', 06:14:11 INFO - 'create-virtualenv', 06:14:11 INFO - 'install', 06:14:11 INFO - 'run-tests'), 06:14:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:11 INFO - 'download_minidump_stackwalk': True, 06:14:11 INFO - 'download_symbols': 'ondemand', 06:14:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:11 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:11 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:11 INFO - 'installer_path': 'installer.exe', 06:14:11 INFO - 'log_level': 'info', 06:14:11 INFO - 'log_name': 'talos', 06:14:11 INFO - 'log_to_console': True, 06:14:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:11 INFO - 'opt_config_files': (), 06:14:11 INFO - 'pip_index': False, 06:14:11 INFO - 'sps_profile': False, 06:14:11 INFO - 'sps_profile_interval': 0, 06:14:11 INFO - 'suite': 'dromaeojs', 06:14:11 INFO - 'system_bits': '32', 06:14:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:11 INFO - 'title': 'talos-linux64-ix-020', 06:14:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:11 INFO - 'use_talos_json': True, 06:14:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:11 INFO - 'work_dir': 'build'} 06:14:11 INFO - [mozharness: 2017-02-07 14:14:11.617739Z] Running clobber step. 06:14:11 INFO - Running pre-action listener: _resource_record_pre_action 06:14:11 INFO - Running main action method: clobber 06:14:11 INFO - rmtree: /builds/slave/test/build 06:14:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:12 INFO - Running post-action listener: _resource_record_post_action 06:14:12 INFO - [mozharness: 2017-02-07 14:14:12.095891Z] Finished clobber step (success) 06:14:12 INFO - [mozharness: 2017-02-07 14:14:12.096003Z] Running read-buildbot-config step. 06:14:12 INFO - Running pre-action listener: _resource_record_pre_action 06:14:12 INFO - Running main action method: read_buildbot_config 06:14:12 INFO - Using buildbot properties: 06:14:12 INFO - { 06:14:12 INFO - "project": "", 06:14:12 INFO - "product": "firefox", 06:14:12 INFO - "who": "cbook@mozilla.com", 06:14:12 INFO - "installer_path": "public/build/target.tar.bz2", 06:14:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:14:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:14:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:14:12 INFO - "stage_platform": "linux64-pgo", 06:14:12 INFO - "basedir": "/builds/slave/test", 06:14:12 INFO - "buildnumber": 18, 06:14:12 INFO - "platform": "ubuntu64_hw", 06:14:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:14:12 INFO - "slavebuilddir": "test", 06:14:12 INFO - "taskId": "RqdMbf9HSgeb6vRqzq8fvA", 06:14:12 INFO - "branch": "mozilla-central", 06:14:12 INFO - "script_repo_revision": "production", 06:14:12 INFO - "revision": "6d27535f4fe912068e0a0ac5854f7f39e94964a5", 06:14:12 INFO - "slavename": "talos-linux64-ix-020", 06:14:12 INFO - "repo_path": "mozilla-central" 06:14:12 INFO - } 06:14:12 INFO - Finding installer, test and symbols from parent task. 06:14:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RqdMbf9HSgeb6vRqzq8fvA'}, attempt #1 06:14:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RqdMbf9HSgeb6vRqzq8fvA'}, attempt #1 06:14:13 INFO - Task dependencies: cIhEByCHT-in_wXCTH24QQ 06:14:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ'}, attempt #1 06:14:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.tar.bz2 06:14:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/test_packages.json 06:14:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.crashreporter-symbols.zip 06:14:13 INFO - Running post-action listener: _resource_record_post_action 06:14:13 INFO - [mozharness: 2017-02-07 14:14:13.508023Z] Finished read-buildbot-config step (success) 06:14:13 INFO - [mozharness: 2017-02-07 14:14:13.508244Z] Running download-and-extract step. 06:14:13 INFO - Running pre-action listener: _resource_record_pre_action 06:14:13 INFO - Running main action method: download_and_extract 06:14:13 INFO - mkdir: /builds/slave/test/build/tests 06:14: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')]} 06:14:13 INFO - trying https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.test_packages.json 06:14:13 INFO - Downloading https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:14:14 INFO - Downloaded 896 bytes. 06:14:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:14:14 INFO - Using the following test package requirements: 06:14:14 INFO - {u'common': [u'target.common.tests.zip'], 06:14:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:14:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:14:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:14:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:14:14 INFO - u'mozbase': [u'target.common.tests.zip'], 06:14:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:14:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:14:14 INFO - u'web-platform': [u'target.common.tests.zip', 06:14:14 INFO - u'target.web-platform.tests.zip'], 06:14:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:14:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:14:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.common.tests.zip 06:14:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:14:14 INFO - Fetch https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.common.tests.zip into memory 06:14:15 INFO - Expected file size: 42420712 06:14:15 INFO - Obtained file size: 42420712 06:14:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:14:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.common.tests.zip 06:14:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:14:19 INFO - Fetch https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.common.tests.zip into memory 06:14:20 INFO - Expected file size: 42420712 06:14:20 INFO - Obtained file size: 42420712 06:14:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.talos.tests.zip 06:14:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:14:25 INFO - Fetch https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.talos.tests.zip into memory 06:14:25 INFO - Expected file size: 14403454 06:14:25 INFO - Obtained file size: 14403454 06:14:26 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')]} 06:14:26 INFO - trying https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.tar.bz2 06:14:26 INFO - Downloading https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:14:27 INFO - Downloaded 61646732 bytes. 06:14:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.tar.bz2 06:14:27 INFO - mkdir: /builds/slave/test/properties 06:14:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:27 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:27 INFO - Contents: 06:14:27 INFO - build_url:https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.tar.bz2 06:14:27 INFO - Running post-action listener: _resource_record_post_action 06:14:27 INFO - Running post-action listener: set_extra_try_arguments 06:14:27 INFO - [mozharness: 2017-02-07 14:14:27.311474Z] Finished download-and-extract step (success) 06:14:27 INFO - [mozharness: 2017-02-07 14:14:27.311571Z] Running populate-webroot step. 06:14:27 INFO - Running pre-action listener: _resource_record_pre_action 06:14:27 INFO - Running main action method: populate_webroot 06:14:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:27 INFO - '--tppagecycles', 06:14:27 INFO - '7'], 06:14:27 INFO - 'tests': ['tsvgm']}}, 06:14:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:14:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:14:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:14:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:14:27 INFO - 'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:14:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:14:27 INFO - 'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['damp', 'tps']}, 06:14:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:14:27 INFO - 'tests': ['damp', 'tps']}, 06:14:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['dromaeo_dom']}, 06:14:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['basic_compositor_video']}, 06:14:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:14:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['a11yr', 06:14:27 INFO - 'ts_paint', 06:14:27 INFO - 'tpaint', 06:14:27 INFO - 'sessionrestore', 06:14:27 INFO - 'sessionrestore_no_auto_restore', 06:14:27 INFO - 'tabpaint']}, 06:14:27 INFO - 'other-e10s': {'tests': ['a11yr', 06:14:27 INFO - 'ts_paint', 06:14:27 INFO - 'tpaint', 06:14:27 INFO - 'sessionrestore', 06:14:27 INFO - 'sessionrestore_no_auto_restore', 06:14:27 INFO - 'tabpaint']}, 06:14:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:14:27 INFO - 'ts_paint', 06:14:27 INFO - 'tpaint', 06:14:27 INFO - 'sessionrestore', 06:14:27 INFO - 'sessionrestore_no_auto_restore', 06:14:27 INFO - 'tabpaint']}, 06:14:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:14:27 INFO - 'ts_paint', 06:14:27 INFO - 'tpaint', 06:14:27 INFO - 'sessionrestore', 06:14:27 INFO - 'sessionrestore_no_auto_restore', 06:14:27 INFO - 'tabpaint']}, 06:14:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['a11yr', 06:14:27 INFO - 'ts_paint', 06:14:27 INFO - 'tpaint', 06:14:27 INFO - 'sessionrestore', 06:14:27 INFO - 'sessionrestore_no_auto_restore', 06:14:27 INFO - 'tabpaint']}, 06:14:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['a11yr', 06:14:27 INFO - 'ts_paint', 06:14:27 INFO - 'tpaint', 06:14:27 INFO - 'sessionrestore', 06:14:27 INFO - 'sessionrestore_no_auto_restore', 06:14:27 INFO - 'tabpaint']}, 06:14:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['tsvgx', 06:14:27 INFO - 'tsvgr_opacity', 06:14:27 INFO - 'tart', 06:14:27 INFO - 'tscrollx', 06:14:27 INFO - 'cart', 06:14:27 INFO - 'tsvg_static']}, 06:14:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:14:27 INFO - 'tsvgr_opacity', 06:14:27 INFO - 'tart', 06:14:27 INFO - 'tscrollx', 06:14:27 INFO - 'cart', 06:14:27 INFO - 'tsvg_static']}, 06:14:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:14:27 INFO - 'talos_options': ['--disable-e10s'], 06:14:27 INFO - 'tests': ['tp5o']}, 06:14:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:14:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:14:27 INFO - 'talos_options': ['--disable-e10s', 06:14:27 INFO - '--xperf_path', 06:14:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:27 INFO - 'tests': ['tp5n']}, 06:14:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:14:27 INFO - 'talos_options': ['--xperf_path', 06:14:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:27 INFO - 'tests': ['tp5n']}}, 06:14:27 INFO - 'talos.zip': {'path': '', 06:14:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:27 INFO - Running post-action listener: _resource_record_post_action 06:14:27 INFO - [mozharness: 2017-02-07 14:14:27.324759Z] Finished populate-webroot step (success) 06:14:27 INFO - [mozharness: 2017-02-07 14:14:27.324853Z] Running create-virtualenv step. 06:14:27 INFO - Running pre-action listener: _resource_record_pre_action 06:14:27 INFO - Running main action method: create_virtualenv 06:14:27 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:27 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 06:14:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:27 INFO - Using real prefix '/usr' 06:14:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:27 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:29 INFO - Installing pip.................done. 06:14:29 INFO - Return code: 0 06:14:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:14:30 INFO - Reading from file tmpfile_stdout 06:14:30 INFO - Output received: 06:14:30 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) 06:14:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14:30 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')]} 06:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:30 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')]} 06:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:30 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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:30 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 06:14:30 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 06:14:30 INFO - Using env: {'DISPLAY': ':0', 06:14:30 INFO - 'HOME': '/home/cltbld', 06:14:30 INFO - 'LANG': 'en_US.UTF-8', 06:14:30 INFO - 'LANGUAGE': 'en_US:en', 06:14:30 INFO - 'LOGNAME': 'cltbld', 06:14:30 INFO - 'MAIL': '/var/mail/cltbld', 06:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:30 INFO - 'MOZ_NO_REMOTE': '1', 06:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:30 INFO - 'NO_EM_RESTART': '1', 06:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:30 INFO - 'PWD': '/builds/slave/test', 06:14:30 INFO - 'SHELL': '/bin/bash', 06:14:30 INFO - 'SHLVL': '1', 06:14:30 INFO - 'TERM': 'linux', 06:14:30 INFO - 'TMOUT': '86400', 06:14:30 INFO - 'USER': 'cltbld', 06:14:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:30 INFO - '_': '/tools/buildbot/bin/python'} 06:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:30 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 06:14:30 INFO - Cleaning up... 06:14:30 INFO - Return code: 0 06:14:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:14:30 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')]} 06:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:30 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')]} 06:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:30 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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:30 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 06:14:30 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 06:14:30 INFO - Using env: {'DISPLAY': ':0', 06:14:30 INFO - 'HOME': '/home/cltbld', 06:14:30 INFO - 'LANG': 'en_US.UTF-8', 06:14:30 INFO - 'LANGUAGE': 'en_US:en', 06:14:30 INFO - 'LOGNAME': 'cltbld', 06:14:30 INFO - 'MAIL': '/var/mail/cltbld', 06:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:30 INFO - 'MOZ_NO_REMOTE': '1', 06:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:30 INFO - 'NO_EM_RESTART': '1', 06:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:30 INFO - 'PWD': '/builds/slave/test', 06:14:30 INFO - 'SHELL': '/bin/bash', 06:14:30 INFO - 'SHLVL': '1', 06:14:30 INFO - 'TERM': 'linux', 06:14:30 INFO - 'TMOUT': '86400', 06:14:30 INFO - 'USER': 'cltbld', 06:14:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:30 INFO - '_': '/tools/buildbot/bin/python'} 06:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:30 INFO - Downloading/unpacking psutil>=3.1.1 06:14:30 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 06:14:30 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 06:14:30 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 06:14:30 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 06:14:30 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 06:14:30 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 06:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:32 INFO - Installing collected packages: psutil 06:14:32 INFO - Running setup.py install for psutil 06:14:32 INFO - building 'psutil._psutil_linux' extension 06:14:32 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 06:14:32 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 06:14:32 INFO - building 'psutil._psutil_posix' extension 06:14:32 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 06:14:33 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 06:14:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:33 INFO - Successfully installed psutil 06:14:33 INFO - Cleaning up... 06:14:33 INFO - Return code: 0 06:14:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:33 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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:33 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 06:14:33 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 06:14:33 INFO - Using env: {'DISPLAY': ':0', 06:14:33 INFO - 'HOME': '/home/cltbld', 06:14:33 INFO - 'LANG': 'en_US.UTF-8', 06:14:33 INFO - 'LANGUAGE': 'en_US:en', 06:14:33 INFO - 'LOGNAME': 'cltbld', 06:14:33 INFO - 'MAIL': '/var/mail/cltbld', 06:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:33 INFO - 'MOZ_NO_REMOTE': '1', 06:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:33 INFO - 'NO_EM_RESTART': '1', 06:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:33 INFO - 'PWD': '/builds/slave/test', 06:14:33 INFO - 'SHELL': '/bin/bash', 06:14:33 INFO - 'SHLVL': '1', 06:14:33 INFO - 'TERM': 'linux', 06:14:33 INFO - 'TMOUT': '86400', 06:14:33 INFO - 'USER': 'cltbld', 06:14:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:33 INFO - '_': '/tools/buildbot/bin/python'} 06:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:14:33 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 06:14:33 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 06:14:33 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 06:14:33 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 06:14:33 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 06:14:33 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 06:14:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:14:35 INFO - Installing collected packages: mozsystemmonitor 06:14:35 INFO - Running setup.py install for mozsystemmonitor 06:14:35 INFO - Successfully installed mozsystemmonitor 06:14:35 INFO - Cleaning up... 06:14:35 INFO - Return code: 0 06:14:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:14:35 INFO - Using env: {'DISPLAY': ':0', 06:14:35 INFO - 'HOME': '/home/cltbld', 06:14:35 INFO - 'LANG': 'en_US.UTF-8', 06:14:35 INFO - 'LANGUAGE': 'en_US:en', 06:14:35 INFO - 'LOGNAME': 'cltbld', 06:14:35 INFO - 'MAIL': '/var/mail/cltbld', 06:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:35 INFO - 'MOZ_NO_REMOTE': '1', 06:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:35 INFO - 'NO_EM_RESTART': '1', 06:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:35 INFO - 'PWD': '/builds/slave/test', 06:14:35 INFO - 'SHELL': '/bin/bash', 06:14:35 INFO - 'SHLVL': '1', 06:14:35 INFO - 'TERM': 'linux', 06:14:35 INFO - 'TMOUT': '86400', 06:14:35 INFO - 'USER': 'cltbld', 06:14:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:35 INFO - '_': '/tools/buildbot/bin/python'} 06:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:35 INFO - Downloading/unpacking jsonschema==2.5.1 06:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:14:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:14:37 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 06:14:37 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 06:14:37 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 06:14:37 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 06:14:37 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 06:14:37 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 06:14:38 INFO - Downloading functools32-3.2.3-2.tar.gz 06:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:14:38 INFO - warning: no files found matching '*.txt' 06:14:38 INFO - no previously-included directories found matching 'build' 06:14:38 INFO - no previously-included directories found matching 'dist' 06:14:38 INFO - no previously-included directories found matching '.git*' 06:14:38 INFO - Installing collected packages: jsonschema, functools32 06:14:38 INFO - Running setup.py install for functools32 06:14:38 INFO - warning: no files found matching '*.txt' 06:14:38 INFO - no previously-included directories found matching 'build' 06:14:38 INFO - no previously-included directories found matching 'dist' 06:14:38 INFO - no previously-included directories found matching '.git*' 06:14:38 INFO - Successfully installed jsonschema functools32 06:14:38 INFO - Cleaning up... 06:14:38 INFO - Return code: 0 06:14:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:14:38 INFO - Using env: {'DISPLAY': ':0', 06:14:38 INFO - 'HOME': '/home/cltbld', 06:14:38 INFO - 'LANG': 'en_US.UTF-8', 06:14:38 INFO - 'LANGUAGE': 'en_US:en', 06:14:38 INFO - 'LOGNAME': 'cltbld', 06:14:38 INFO - 'MAIL': '/var/mail/cltbld', 06:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:38 INFO - 'MOZ_NO_REMOTE': '1', 06:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:38 INFO - 'NO_EM_RESTART': '1', 06:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:38 INFO - 'PWD': '/builds/slave/test', 06:14:38 INFO - 'SHELL': '/bin/bash', 06:14:38 INFO - 'SHLVL': '1', 06:14:38 INFO - 'TERM': 'linux', 06:14:38 INFO - 'TMOUT': '86400', 06:14:38 INFO - 'USER': 'cltbld', 06:14:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:38 INFO - '_': '/tools/buildbot/bin/python'} 06:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:14:38 INFO - Cleaning up... 06:14:38 INFO - Return code: 0 06:14:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:14:38 INFO - Using env: {'DISPLAY': ':0', 06:14:38 INFO - 'HOME': '/home/cltbld', 06:14:38 INFO - 'LANG': 'en_US.UTF-8', 06:14:38 INFO - 'LANGUAGE': 'en_US:en', 06:14:38 INFO - 'LOGNAME': 'cltbld', 06:14:38 INFO - 'MAIL': '/var/mail/cltbld', 06:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:38 INFO - 'MOZ_NO_REMOTE': '1', 06:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:38 INFO - 'NO_EM_RESTART': '1', 06:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:38 INFO - 'PWD': '/builds/slave/test', 06:14:38 INFO - 'SHELL': '/bin/bash', 06:14:38 INFO - 'SHLVL': '1', 06:14:38 INFO - 'TERM': 'linux', 06:14:38 INFO - 'TMOUT': '86400', 06:14:38 INFO - 'USER': 'cltbld', 06:14:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:38 INFO - '_': '/tools/buildbot/bin/python'} 06:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:38 INFO - Downloading/unpacking blobuploader==1.2.4 06:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:40 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14:40 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 06:14:40 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 06:14:40 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 06:14:40 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 06:14:40 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 06:14:40 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 06:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:41 INFO - Downloading docopt-0.6.1.tar.gz 06:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:41 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:41 INFO - Running setup.py install for blobuploader 06:14:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:41 INFO - Running setup.py install for requests 06:14:42 INFO - Running setup.py install for docopt 06:14:42 INFO - Successfully installed blobuploader requests docopt 06:14:42 INFO - Cleaning up... 06:14:42 INFO - Return code: 0 06:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:42 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')]} 06:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:42 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')]} 06:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:42 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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:42 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 06:14:42 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 06:14:42 INFO - Using env: {'DISPLAY': ':0', 06:14:42 INFO - 'HOME': '/home/cltbld', 06:14:42 INFO - 'LANG': 'en_US.UTF-8', 06:14:42 INFO - 'LANGUAGE': 'en_US:en', 06:14:42 INFO - 'LOGNAME': 'cltbld', 06:14:42 INFO - 'MAIL': '/var/mail/cltbld', 06:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:42 INFO - 'MOZ_NO_REMOTE': '1', 06:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:42 INFO - 'NO_EM_RESTART': '1', 06:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:42 INFO - 'PWD': '/builds/slave/test', 06:14:42 INFO - 'SHELL': '/bin/bash', 06:14:42 INFO - 'SHLVL': '1', 06:14:42 INFO - 'TERM': 'linux', 06:14:42 INFO - 'TMOUT': '86400', 06:14:42 INFO - 'USER': 'cltbld', 06:14:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:42 INFO - '_': '/tools/buildbot/bin/python'} 06:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:42 INFO - Running setup.py (path:/tmp/pip-_GHMXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:42 INFO - Running setup.py (path:/tmp/pip-WaIXNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:42 INFO - Running setup.py (path:/tmp/pip-_JvQyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:42 INFO - Running setup.py (path:/tmp/pip-MGSIeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:42 INFO - Running setup.py (path:/tmp/pip-pNswP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:42 INFO - Running setup.py (path:/tmp/pip-hPBe74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:43 INFO - Running setup.py (path:/tmp/pip-nqmA1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:43 INFO - Running setup.py (path:/tmp/pip-rpBaeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:43 INFO - Running setup.py (path:/tmp/pip-EKrD_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:43 INFO - Running setup.py (path:/tmp/pip-YaBwjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:43 INFO - Running setup.py (path:/tmp/pip-7iB16V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:43 INFO - Running setup.py (path:/tmp/pip-kxUSHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:43 INFO - Running setup.py (path:/tmp/pip-iA1Xix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:43 INFO - Running setup.py (path:/tmp/pip-7VIPgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:43 INFO - Running setup.py (path:/tmp/pip-1QEZ7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:43 INFO - Running setup.py (path:/tmp/pip-hziCMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:43 INFO - Running setup.py (path:/tmp/pip-rTIQqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:43 INFO - Running setup.py install for manifestparser 06:14:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:43 INFO - Running setup.py install for mozcrash 06:14:43 INFO - Running setup.py install for mozdebug 06:14:44 INFO - Running setup.py install for mozdevice 06:14:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Running setup.py install for mozfile 06:14:44 INFO - Running setup.py install for mozhttpd 06:14:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Running setup.py install for mozinfo 06:14:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Running setup.py install for mozInstall 06:14:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Running setup.py install for mozleak 06:14:44 INFO - Running setup.py install for mozlog 06:14:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Running setup.py install for moznetwork 06:14:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:44 INFO - Running setup.py install for mozprocess 06:14:44 INFO - Running setup.py install for mozprofile 06:14:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:45 INFO - Running setup.py install for mozrunner 06:14:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:45 INFO - Running setup.py install for mozscreenshot 06:14:45 INFO - Running setup.py install for moztest 06:14:45 INFO - Running setup.py install for mozversion 06:14:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:45 INFO - Cleaning up... 06:14:45 INFO - Return code: 0 06:14:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:45 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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:45 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 06:14:45 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 06:14:45 INFO - Using env: {'DISPLAY': ':0', 06:14:45 INFO - 'HOME': '/home/cltbld', 06:14:45 INFO - 'LANG': 'en_US.UTF-8', 06:14:45 INFO - 'LANGUAGE': 'en_US:en', 06:14:45 INFO - 'LOGNAME': 'cltbld', 06:14:45 INFO - 'MAIL': '/var/mail/cltbld', 06:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:45 INFO - 'MOZ_NO_REMOTE': '1', 06:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:45 INFO - 'NO_EM_RESTART': '1', 06:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:45 INFO - 'PWD': '/builds/slave/test', 06:14:45 INFO - 'SHELL': '/bin/bash', 06:14:45 INFO - 'SHLVL': '1', 06:14:45 INFO - 'TERM': 'linux', 06:14:45 INFO - 'TMOUT': '86400', 06:14:45 INFO - 'USER': 'cltbld', 06:14:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:45 INFO - '_': '/tools/buildbot/bin/python'} 06:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:45 INFO - Running setup.py (path:/tmp/pip-qjnEDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:45 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)) 06:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:45 INFO - Running setup.py (path:/tmp/pip-FHEGxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:45 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)) 06:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:45 INFO - Running setup.py (path:/tmp/pip-ImeAXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:45 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)) 06:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:45 INFO - Running setup.py (path:/tmp/pip-xUJqsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:46 INFO - Running setup.py (path:/tmp/pip-10c1XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:46 INFO - Running setup.py (path:/tmp/pip-4zOPC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:46 INFO - Running setup.py (path:/tmp/pip-bhETdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:46 INFO - Running setup.py (path:/tmp/pip-sJuIud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:46 INFO - Running setup.py (path:/tmp/pip-FBI_A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:46 INFO - Running setup.py (path:/tmp/pip-C3CGIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:46 INFO - Running setup.py (path:/tmp/pip-9qINUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:46 INFO - Running setup.py (path:/tmp/pip-oYdDal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:46 INFO - Running setup.py (path:/tmp/pip-5U3qlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:46 INFO - Running setup.py (path:/tmp/pip-IwMRR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:46 INFO - Running setup.py (path:/tmp/pip-HqQo5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:46 INFO - Running setup.py (path:/tmp/pip-ziAbUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:46 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)) 06:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:46 INFO - Running setup.py (path:/tmp/pip-Z8qv4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:46 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)) 06:14:46 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)) 06:14:46 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)) 06:14:46 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)) 06:14:47 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)) 06:14:47 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)) 06:14:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14:47 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 06:14:47 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 06:14:47 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 06:14:47 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 06:14:47 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 06:14:47 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 06:14:49 INFO - Downloading blessings-1.6.tar.gz 06:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:14:49 INFO - Installing collected packages: blessings 06:14:49 INFO - Running setup.py install for blessings 06:14:49 INFO - Successfully installed blessings 06:14:49 INFO - Cleaning up... 06:14:49 INFO - Return code: 0 06:14:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:49 INFO - Reading from file tmpfile_stdout 06:14:49 INFO - Current package versions: 06:14:49 INFO - argparse == 1.2.1 06:14:49 INFO - blessings == 1.6 06:14:49 INFO - blobuploader == 1.2.4 06:14:49 INFO - docopt == 0.6.1 06:14:49 INFO - functools32 == 3.2.3-2 06:14:49 INFO - jsonschema == 2.5.1 06:14:49 INFO - manifestparser == 1.1 06:14:49 INFO - mozInstall == 1.12 06:14:49 INFO - mozcrash == 1.0 06:14:49 INFO - mozdebug == 0.1 06:14:49 INFO - mozdevice == 0.49 06:14:49 INFO - mozfile == 1.2 06:14:49 INFO - mozhttpd == 0.7 06:14:49 INFO - mozinfo == 0.9 06:14:49 INFO - mozleak == 0.1 06:14:49 INFO - mozlog == 3.4 06:14:49 INFO - moznetwork == 0.27 06:14:49 INFO - mozprocess == 0.24 06:14:49 INFO - mozprofile == 0.28 06:14:49 INFO - mozrunner == 6.13 06:14:49 INFO - mozscreenshot == 0.1 06:14:49 INFO - mozsystemmonitor == 0.3 06:14:49 INFO - moztest == 0.8 06:14:49 INFO - mozversion == 1.4 06:14:49 INFO - psutil == 3.1.1 06:14:49 INFO - requests == 1.2.3 06:14:49 INFO - wsgiref == 0.1.2 06:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:49 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')]} 06:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:49 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')]} 06:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:49 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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:49 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 06:14:49 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 06:14:49 INFO - Using env: {'DISPLAY': ':0', 06:14:49 INFO - 'HOME': '/home/cltbld', 06:14:49 INFO - 'LANG': 'en_US.UTF-8', 06:14:49 INFO - 'LANGUAGE': 'en_US:en', 06:14:49 INFO - 'LOGNAME': 'cltbld', 06:14:49 INFO - 'MAIL': '/var/mail/cltbld', 06:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:49 INFO - 'MOZ_NO_REMOTE': '1', 06:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:49 INFO - 'NO_EM_RESTART': '1', 06:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:49 INFO - 'PWD': '/builds/slave/test', 06:14:49 INFO - 'SHELL': '/bin/bash', 06:14:49 INFO - 'SHLVL': '1', 06:14:49 INFO - 'TERM': 'linux', 06:14:49 INFO - 'TMOUT': '86400', 06:14:49 INFO - 'USER': 'cltbld', 06:14:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:49 INFO - '_': '/tools/buildbot/bin/python'} 06:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 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)) 06:14:49 INFO - Cleaning up... 06:14:49 INFO - Return code: 0 06:14:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:14:49 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')]} 06:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:49 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')]} 06:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:49 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 0x16b81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1884a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a29c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', '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 06:14:49 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 06:14:49 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 06:14:49 INFO - Using env: {'DISPLAY': ':0', 06:14:49 INFO - 'HOME': '/home/cltbld', 06:14:49 INFO - 'LANG': 'en_US.UTF-8', 06:14:49 INFO - 'LANGUAGE': 'en_US:en', 06:14:49 INFO - 'LOGNAME': 'cltbld', 06:14:49 INFO - 'MAIL': '/var/mail/cltbld', 06:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:49 INFO - 'MOZ_NO_REMOTE': '1', 06:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:49 INFO - 'NO_EM_RESTART': '1', 06:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:49 INFO - 'PWD': '/builds/slave/test', 06:14:49 INFO - 'SHELL': '/bin/bash', 06:14:49 INFO - 'SHLVL': '1', 06:14:49 INFO - 'TERM': 'linux', 06:14:49 INFO - 'TMOUT': '86400', 06:14:49 INFO - 'USER': 'cltbld', 06:14:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:49 INFO - '_': '/tools/buildbot/bin/python'} 06:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:14:50 INFO - Cleaning up... 06:14:50 INFO - Return code: 0 06:14:50 INFO - Running post-action listener: _resource_record_post_action 06:14:50 INFO - Running post-action listener: _start_resource_monitoring 06:14:50 INFO - Starting resource monitoring. 06:14:50 INFO - [mozharness: 2017-02-07 14:14:50.068799Z] Finished create-virtualenv step (success) 06:14:50 INFO - [mozharness: 2017-02-07 14:14:50.069254Z] Running install step. 06:14:50 INFO - Running pre-action listener: _resource_record_pre_action 06:14:50 INFO - Running main action method: install 06:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:50 INFO - Reading from file tmpfile_stdout 06:14:50 INFO - Detecting whether we're running mozinstall >=1.0... 06:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:14:50 INFO - Reading from file tmpfile_stdout 06:14:50 INFO - Output received: 06:14:50 INFO - Usage: mozinstall [options] installer 06:14:50 INFO - Options: 06:14:50 INFO - -h, --help show this help message and exit 06:14:50 INFO - -d DEST, --destination=DEST 06:14:50 INFO - Directory to install application into. [default: 06:14:50 INFO - "/builds/slave/test"] 06:14:50 INFO - --app=APP Application being installed. [default: firefox] 06:14:50 INFO - mkdir: /builds/slave/test/build/application 06:14:50 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'] 06:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:15:07 INFO - Reading from file tmpfile_stdout 06:15:07 INFO - Output received: 06:15:07 INFO - /builds/slave/test/build/application/firefox/firefox 06:15:07 INFO - Running post-action listener: _resource_record_post_action 06:15:07 INFO - [mozharness: 2017-02-07 14:15:07.960722Z] Finished install step (success) 06:15:07 INFO - [mozharness: 2017-02-07 14:15:07.960997Z] Running run-tests step. 06:15:07 INFO - Running pre-action listener: _resource_record_pre_action 06:15:07 INFO - Running main action method: run_tests 06:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:07 INFO - Python 2.7.3 06:15:07 INFO - Return code: 0 06:15:07 INFO - grabbing minidump binary from tooltool 06:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:07 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 0x1a273f0>, '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 0x1a27cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a281a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:07 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 06:15:07 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 06:15:07 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 06:15:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:08 INFO - Return code: 0 06:15:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:15:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:15:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 06:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 06:15:08 INFO - Using env: {'DISPLAY': ':0', 06:15:08 INFO - 'HOME': '/home/cltbld', 06:15:08 INFO - 'LANG': 'en_US.UTF-8', 06:15:08 INFO - 'LANGUAGE': 'en_US:en', 06:15:08 INFO - 'LOGNAME': 'cltbld', 06:15:08 INFO - 'MAIL': '/var/mail/cltbld', 06:15:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:08 INFO - 'MOZ_NO_REMOTE': '1', 06:15:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:08 INFO - 'NO_EM_RESTART': '1', 06:15:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:08 INFO - 'PWD': '/builds/slave/test', 06:15:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:08 INFO - 'SHELL': '/bin/bash', 06:15:08 INFO - 'SHLVL': '1', 06:15:08 INFO - 'TERM': 'linux', 06:15:08 INFO - 'TMOUT': '86400', 06:15:08 INFO - 'USER': 'cltbld', 06:15:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424', 06:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:08 INFO - '_': '/tools/buildbot/bin/python'} 06:15:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 06:15:08 INFO - mozversion application_buildid: 20170207130905 06:15:08 INFO - mozversion application_changeset: 6d27535f4fe912068e0a0ac5854f7f39e94964a5 06:15:08 INFO - mozversion application_display_name: Nightly 06:15:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:08 INFO - mozversion application_name: Firefox 06:15:08 INFO - mozversion application_remotingname: firefox 06:15:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:15:08 INFO - mozversion application_vendor: Mozilla 06:15:08 INFO - mozversion application_version: 54.0a1 06:15:08 INFO - mozversion platform_buildid: 20170207130905 06:15:08 INFO - mozversion platform_changeset: 6d27535f4fe912068e0a0ac5854f7f39e94964a5 06:15:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:15:08 INFO - mozversion platform_version: 54.0a1 06:15:08 INFO - using testdate: 1486476908 06:15:08 INFO - actual date: 1486476908 06:15:08 INFO - starting webserver on 'localhost:37402' 06:15:08 INFO - SUITE-START | Running 2 tests 06:15:08 INFO - TEST-START | dromaeo_css 06:15:08 INFO - operating with platform_type : linux_ 06:15:08 INFO - Initialising browser for dromaeo_css test... 06:15:08 INFO - TEST-INFO | started process 3611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1IE0Wj/profile http://localhost:37402/getInfo.html) 06:15:11 INFO - PROCESS | 3611 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 06:15:12 INFO - PROCESS | 3611 | __metrics Screen width/height:1600/1200 06:15:12 INFO - PROCESS | 3611 | colorDepth:24 06:15:12 INFO - PROCESS | 3611 | Browser inner width/height: 1024/697 06:15:12 INFO - PROCESS | 3611 | __metrics 06:15:13 INFO - PROCESS | 3611 | 1486476913161 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 06:15:13 INFO - PROCESS | 3611 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:15:13 INFO - PROCESS | 3611 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:15:14 INFO - TEST-INFO | 3611: exit 0 06:15:14 INFO - Browser initialized. 06:15:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:14 INFO - TEST-INFO | started process 3694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1IE0Wj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:26 INFO - PROCESS | 3694 | RSS: Main: 149131264 06:15:26 INFO - PROCESS | 3694 | 06:18:27 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:37402/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37402/tests/dromaeo/cssquery-ext.html) 06:18:29 INFO - PROCESS | 3694 | RSS: Main: 355213312 06:18:29 INFO - PROCESS | 3694 | 06:20:16 INFO - PROCESS | 3694 | ************************* 06:20:16 INFO - PROCESS | 3694 | A coding exception was thrown and uncaught in a Task. 06:20:16 INFO - PROCESS | 3694 | 06:20:16 ERROR - PROCESS | 3694 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:20:16 INFO - PROCESS | 3694 | Full stack: 06:20:16 INFO - PROCESS | 3694 | ************************* 06:21:32 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:37402/tests/dromaeo/cssquery-ext.html (next: http://localhost:37402/tests/dromaeo/cssquery-jquery.html) 06:21:32 INFO - PROCESS | 3694 | RSS: Main: 250097664 06:21:32 INFO - PROCESS | 3694 | 06:24:34 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:37402/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37402/tests/dromaeo/cssquery-mootools.html) 06:24:35 INFO - PROCESS | 3694 | RSS: Main: 187867136 06:24:35 INFO - PROCESS | 3694 | 06:27:37 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:37402/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37402/tests/dromaeo/cssquery-prototype.html) 06:27:38 INFO - PROCESS | 3694 | RSS: Main: 229097472 06:27:38 INFO - PROCESS | 3694 | 06:30:40 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:37402/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37402/tests/dromaeo/cssquery-yui.html) 06:30:41 INFO - PROCESS | 3694 | RSS: Main: 186839040 06:30:41 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | Cycle 1(1): loaded http://localhost:37402/tests/dromaeo/cssquery-yui.html (next: http://localhost:37402/tests/dromaeo/cssquery-dojo.html) 06:33:44 INFO - PROCESS | 3694 | RSS: Main: 278761472 06:33:44 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | __start_tp_report 06:33:44 INFO - PROCESS | 3694 | _x_x_mozilla_page_load 06:33:44 INFO - PROCESS | 3694 | _x_x_mozilla_page_load_details 06:33:44 INFO - PROCESS | 3694 | |i|pagename|runs| 06:33:44 INFO - PROCESS | 3694 | |0;dojo.html;3139.9843000784995;3156.5107408351714;3188.4739018062005;3192.26577887086;3197.888073917412;5240.842774716755;5276.973615131924;5300.337457817773;5337.813176538822;5443.156310771837;5302.814401495948;5304.336957880265;5331.866703332418;5362.034833729927;5380.542653874425;4518.864434066967;4684.531546845323;4875.24433712775;4882.536159064901;4885.8778530536665;4699.271612900006;4746.430428348603;4782.856514304576;4846.515348465161;4852.684575502599;4699.271612900006;4736.313234581001;4768.189407800647;4814.7351895645725;4846.103470857903;4753.548412900769;4763.7141771493825;4770.76146192689;4770.95229047712;4799.544043315915;4699.835505757282;4724.196886529298;4763.928541071887;4778.139934811733;4821.493743156988;5273.393559740641;5275.57795376369;5299.496547827989;5304.071787437183;5371.4897084776885;5692.800751973661;5710.371859095496;5711.8000869969355;5722.113072473773;5728.083506638918;5743.62666426681;5747.109198074305;5762.683052432115;5764.855878603026;5770.365259821417;5252.894942101175;5289.656172348824;5306.708131052829;5332.093544097513;5406.864828379244;5847.970760146172;5851.561132915049;5854.560907931922;5868.501177399883;5894.764209431661;5475;5492.588055895744;5530;5530.11518157101;5604.32748070226;5711.543076553949;5711.971440142773;5717.085266357363;5717.456841600041;5719.370869204384;5676.035074037423;5676.432356764373;5685.857853553694;5686.3744988051285;5691.9146212806845;5690.886182276414;5699.5155411790465;5700.173474846207;5701.087825947829;5702.287214098238;4420.292753159543;4427.335899615084;4434.822607095744;4437.911241775211;4528.366028755977;3947.684185265172;3961.3859851723028;3988.0428697112484;4015.3374693175297;4026.154507553388;5435.239066530688;5462.044142275086;5474.753636086386;5485.588580856452;5514.944850551524;5757.539396848326;5762.510186634099;5763.538916886639;5765.423457654201;5774.3070831499645;5301.443348448357;5338.439463856317;5453.372862120907;5456.290682211287;5464.26232458621;4886.047220791911;4891.706497610155;4893.266010098514;4930.137225985438;4975.353204083446;5990.041593345044;6000.819975400745;6005.849853753691;6033.306169790442;6056.878862422727;5718.914216286676;5728.283964504437;5728.570357223141;5730.828075157752;5747.3103227612955;5815.651060936358;5827.854303642273;5869.618474799125;5967.6419414835245;5980.312264089685;5565.6104072714525;5600.831975040755;5609.607327487037;5611.80358687444;5623.437656234344;5672.5745569081655;5701.230333904869;5705.4579814917515;5707.6575405475805;5712.11462223356;5500.752466138953;5523.751431185687;5524.779008839601;5531.03206938776;5544.0575102231915;5564.582656300713;5569.248151499658;5582.302212223472;5608.186812912187;5622.746976385991;5438.945610543844;5541.445855414427;5547.223388725501;5551.611387202857;5552.028395030773;5491.725413729378;5529.253550770594;5567.8608034797835;5588.16177573351;5589.664620122806;5435.592330575144;5447;5454.9727251365075;5457.754401052041;5491.533219676372 06:33:44 INFO - PROCESS | 3694 | |1;ext.html;550.8843142939983;576.3832699012058;584.6053913608313;597.8624916269258;622.7384498510625;41803;44291;44395.112097758065;47985;48222.75888620552;44525.332120018225;44906.550934490646;45237.77381113098;45303;45317.546824531746;7627.427942904276;8438.156184381543;8764.298856091498;8767.649294028231;8768.123187681245;7644.61776911155;10701.357918524913;10957.890421095806;10958.671239862817;11247.325160490356;10890.782184356309;10970.725731856688;10974.122070234402;10980.615678451215;10984.615538456155;10723.624673136403;10770.515326810313;10776.73058173548;10783.62257320998;10823.945880270627;10181.134603558632;10295.073443390056;10302.639407620698;10303.690889273334;10303.690889273334;42516.14967700659;42871.35692964577;42887.35668964968;42902.14195716068;42947.785261073805;3948.624880636335;3993.28120938231;3993.4608827808456;3995.700322475826;4002.4990628514306;30654.90521174108;30717.23206919845;30988.53517197244;31566.684333156834;32258.516122258185;3943.4676318696897;3945.0729078666777;4007.73949693269;4042.8787136385954;4045.19096180765;299724;300882;300882;301019;302525;50710;51815;58776.70611646914;59015;59020.40979590149;66173.66913165404;66556.33443665598;67585.66207168932;73479.63260183771;74106;16294.266757995918;16646.75029874553;16695.24871380791;16700.66598668044;16758.74861877073;12861.935690321488;13123.343832808321;13147.934260328637;13149.737005259842;13161.53934612303;17825.643487130445;17856.910715446338;17916.193771280323;17960.640787184184;18026.549336266435;6057.42454466825;6066.757329706762;6163.322034576193;6207.782727604603;6208.410201030985;893.5041052215953;894.2488309819782;908.3051465628799;908.8500397434349;930.3069213435898;30590.84704576463;30677.539836902466;30968.380632387678;31059.84470077635;31290.37419251602;1055.9313644613076;1081.605214096849;1090.1823632275793;1090.8200146975819;1093.1145771924766;16176.838231617534;16374.508764737076;16436.75344869828;16686.249118789685;16689.91655041717;450620;455783;456685;457343;457831;62177;62231.6888415555;62256.68871655703;62280.68859655673;62377.37622623716;1355.9728805423836;1385.5843247025853;1392.997042129665;1400.0619584877952;1406.5512522102251;27721.722782772722;29256.26859328534;29279.414411712074;30250.84874575613;30423.391532169677;52972.735136324074;53452.73273633607;53589.464105360006;53620;53625.731871340395;428140;432823;433878;433906;436388;21801;25701.329413588057;26363.340916477242;26625.600615991163;28155.57766633543;39936.2012759749;40030.59969400269;40373.39439908345;40634;40817.59182408138;34342.82828585841;34594.48108278328;34817.47773783345;34874.30251395009;35038.12404689903;34349.484757728154;34420.13949651279;34446.65553344435;34459.13852153616;34548.309033819685;34734.30531389409;34823.825880870434;35521.11197219987;35545.644543554234;35834.10414739652;28938.42123157567;30958.53562196614;31014.379712406077;31219.687803121677;31321.37357252888;23656.645150322416;23816.624855989983;23821.880890595436;23876.40308992289;24264.272071837873 06:33:44 INFO - PROCESS | 3694 | |2;jquery.html;402.2718878829321;429.5466748485081;433.4430257119601;437.52965562020836;438.08003193294087;18641.62716745664;18718.438446846583;20410.489737756565;20538.69191962122;20655;12677.873221267784;19646.410607681755;19680.704789428135;20715.585688286224;20818;5783.392743761908;6033.276006879159;6039.788607398742;6040.0939859021055;6044.335123136451;5742.425757424245;5873.148393482942;5892.175095486636;6006.459418652343;6013.879722405549;5840.912386314209;5889.6171748836405;5900.704964751767;5906.438888305604;5909.6158749681135;5638.379778224392;5757.712114394305;5814.622049566765;5827.562932780037;5832.825015249549;5235.816746413895;5293.311869456985;5297.12597421425;5297.364316282033;5297.735113244361;24101.7589824103;24697.38256543583;24876.129335473353;24896.626550601755;25161.496770064678;2669.225924481898;2761.9171424857286;2763.1710486853863;2785.7214278571983;2786.7770578353684;9672;10534.683959481228;12423.130380873343;14175.291235438186;14470.348834302482;1837.3110083718605;1887.5752955585021;1954.99022504888;1966.5083729067733;1989.254029738848;89383.55308223482;90861.54569227177;91003.54498227533;92302.5384873078;93953.06046939512;11920.284782913053;12078.698032549257;12116.698572006811;12252.877471225353;12386.81419778704;17431;17434.65130697379;17444.738328925076;17477.213525391388;17537;8309.25216730485;8537.573121343908;8538.103499132501;8632.35257355701;8779.780505487413;8063;8064.83870322602;8323;8327.417080804407;8335.958005249344;5131.820386286537;5296.4968328009545;5308.575313974873;5312.867178320495;5470.699111548824;2182.8035476807163;2222.622154233784;2242.1367773407355;2270.1600407848873;2281.1559722902634;832.1137988042715;837.2046555772041;847.4914651919593;855.2003876375609;872.4547158026234;19304.517387065436;19952.20191192365;20818.27136050231;20833.87053584716;21055.473613159487;847.8685803700437;847.877057826624;852.497026754218;857.4298091768903;875.4659657608853;11326.263792853602;11406.771864562828;11471.827922581168;11522.53909843597;11588.76822463546;569198;572396;588841;609752.756181099;610978;77528;83404;84088;100322.4983875076;103946;1002.9899701002896;1048.5386429970788;1053.5838343854289;1066.4827558634056;1068.7274744940146;17155.91422042882;17514.562135946704;17857.196426160594;18000;18122.09389530492;41229.38155927724;42344.57655423407;43863.34204986864;44070.559294407925;45360.77319613381;56290.43709562852;59069.113963289725;59237;60719;61503;8683;8930.19628233462;9139.522123010871;9308;9323.254139668947;9992.400455972665;11675.065994720571;12076.396180191132;13124.606261812161;13353;11223.438828058728;11469.655910322703;11813;11826.645200643994;11880.881191188324;11137.832932505857;11160.330380177214;11229.21395502307;11776.997910355089;11840;11830.349330786545;12137.393130343271;12177.817332739838;12193.756124877631;12209.450574723982;8645.827083458422;8659.177378149066;8886.4668119913;8959.462432254086;9026.097390261184;11184.440777961232;11321.528201333775;11669.533218671497;11882.584109556125;12126.75746485083 06:33:44 INFO - PROCESS | 3694 | |3;mootools.html;1436.6623843396806;1439.2156274830215;1452.070674768148;1457.2932127917961;1458.161557104665;8231.218034286741;8684.609192586333;8692.608832602533;8695.043545210021;8701.434406763556;8337.541435221076;8618.741437756877;8648.827023459527;8777.780555486115;8793.2965362771;2166.3825809644295;2192.583409152264;2196.374033400481;2198.3075331270597;2202.7466841313294;2165.588538177741;2194.1442837293466;2196.901139448729;2201;2220.478187625915;2162.610730068587;2175.1299480207963;2186.8687878727246;2195.901184446696;2201.471646804763;2049.231538173185;2144.3031014920134;2144.431725592719;2155.741311042685;2168.2519530761783;2079;2168.8698678079368;2169.6853956176424;2173.836962227839;2173.9999600183933;8447.662093516252;8496.235338819535;8513.914860851373;8517;8518.105598912087;4912.459629440795;5045.445001049881;5051.116054690415;5052.368453943257;5054.267131265982;2988.4620768261702;3173.841307934617;3205.4550726376574;3206.8236247006407;3233.4826427771677;1227.1593958138615;1298.3118946958127;1300.5903140510804;1316.9012324075636;1367.7401293754156;10417.114545263586;10679.145668346591;10960.671179864617;11523.48144333507;11622.07023438123;4133.4626498555;4247.87256382309;4258.233517966796;4291.742495450283;4317.201317756225;9439.056094390506;9456.290778191664;9457.621695132118;9463.763405914908;9468.14786669203;4277.443932288845;4404.647628189737;4406.25093734066;5038.420581633159;5038.798448062036;4068.8575899843954;4573.199690054227;4672.626189904868;4720.315554244684;4753.35829662998;3437.914052148716;3560.2523470071574;3567.982160089183;3596.892093237207;3637.308911306843;1065.3235195650664;1066.4987455895716;1068.5672302717412;1075.1452595186688;1079.3739631013993;770.4029377232689;890.7238755985666;892.1524551675934;896.7982204004178;921.7050543826045;5417.864553386197;5558.6942718150085;5576.498115169654;5619.831405057773;5891.882461431116;1007.7531004903846;1013.554036224059;1018.7707765752795;1032.1587905856852;1048.3028785857473;3896.357101078347;3924.6271604197555;3987.6211759882763;3996;4001.4998125234347;9958.850617240747;10216.1827053837;10278.972102789661;10284.485775711184;10326.586936522455;9824.607015719434;10090.49547522621;10122.949385253027;10176.440295783656;10198.796024079476;8049.436539442183;8181.590920453954;8187.5087494750505;8190.672373105009;8191.303739182117;5543.307086614173;5649.237352957298;5669.34802497718;5702.657840529581;5821.126830975388;9429.104235097655;9462.621495140118;9465.384749991228;9468.47923364194;9573.712788616353;8472.322214222724;8966.372353935161;9301.534923253945;9335.906640933776;9553.952230238805;6309.432151106423;7194.820129496805;7238.927610724036;7239.4932354734665;7262.709491620276;7813.1796161402235;8059.113497515152;8197.754067377988;8198.139195384638;8220.958895205486;7002.894956575554;7052.400545953651;7054.858902822018;7061.2938706131035;7064.364207221375;6956.443484521327;6968.0941477607585;7022.613756243456;7059.117610298713;7139.928600713926;6341.112244285711;6527.477801775752;6588.868222635616;6593.80218593443;6594.439472644879;4852.344933434082;4904.58311043551;4917.28699338601;4950.381202349707;5125.974370128126;4934.259861020875;5000.449950505369;5007.599392048554;5021.347224860745;5023.547880690755 06:33:44 INFO - PROCESS | 3694 | |4;prototype.html;364.6991232233408;377.1965713031243;384.03798484795584;411.18995578709934;413.86963106621414;4935.876603084916;5084.694948283617;5151.948480515193;5213.244079608459;5217.817376391822;4937.185364414876;5038;5144.845654630358;5204.375474943012;5211.114110601197;4067.9220006698247;4102.384642303648;4137.793110344486;4147.278879265102;4150.418941348214;3826.196498735269;3942.0933185367385;4095.28332541804;4124.649404800595;4131.35963925592;3930.2925473414775;4082.0815316553835;4088.4684990951137;4089.5297040840237;4112.465379500676;4028.8517772435007;4051.4125451809323;4074.5721699221453;4080.326746086892;4090.3046482097966;3705.555333359987;3709.7217708671956;3710.684591809699;3718.7954662493553;3724.1248306647917;4906.828261010884;4995.625328100407;5011.774470148852;5014.197728363444;5031.345925029759;4749.548792864673;4782.569568738795;4784.473707892129;4786.162421576245;4790.952090479121;5463.508284254396;5464.426235245322;5467.316585426822;5474.945250547484;5498.51540084179;3942.172143849795;4090.550039495653;4109.239790638741;4147.357159640261;4149.65544467378;5660.697869619078;5666.235058267122;5674.659520428746;5676.772929082832;5683.318001839764;4245.8513952012145;4255.3616957456625;4261.339492378686;4264.275073237495;4264.744115353089;3866.9226615467533;4098.959010409858;4119.361498967664;4126.360414135814;4326.307790753464;4600.159936025617;4629.375034370384;4633.976830115896;4687.179743544934;4691.46048204454;5479.4520547944885;5484;5502.394736578973;5513.5037846594;5519.902437073966;1373.6703191234033;1374.5257886029303;1390.5897760160776;1404.6699025728944;1405.6977749783846;937.3485427627869;955.603424578806;959.8080383923243;971.6987733802544;972.8443449048118;5127.384713834289;5140.383154021467;5148.382194136728;5171.29347315385;5182.922256166161;5397.70312632809;5487.518370040067;5493.285872836585;5496.340439147328;5513.696746678971;4812.614990800727;5089.491050894881;5116.769745361467;5119.462456442095;5173.094708426011;2869.9282517937218;2872.9513727489316;2874.195225336909;2876.5541341091744;2889.5232286672463;5555.166724991283;5646.774129034875;5654.971725141348;5667.1782591524;5700.429957004267;5348.411674715778;5486.286782718301;5622.550195984311;5714.7428365723645;5733.799317023884;5828.213191219131;5846.473817356458;5860.501857342174;5861.472467477947;5869.530437564985;5461.9453805461435;5590.86022849432;5608.46719561641;5614.943850561442;5627.971860140673;5488.898772193857;5525.585581081516;5529.723513824373;5532.529734972572;5535.308086489189;5775.9133612995;5802.274715660543;5813.970930145322;5825.184474173534;5841.824745257649;4039.636432721069;4187.162567486575;4194.118113986362;4251.5748425157235;4265.317549192115;5411.485908838654;5472.510007946455;5567.387587365468;5583.413741557078;5584.548017515556;5422.593305502024;5434.581611182985;5443.972780136232;5446.455354464681;5447.319085114361;5200.093124167213;5385.946140538545;5418.187271909087;5430.647007944471;5440.591955603267;5391.75737091824;5408.188771684278;5438.673679579238;5447.291852059207;5447.4824891635235;5455.1544510600925;5489.807856724996;5509.264581656766;5516.586256030733;5519.123498010696;4984.302197692398;5295.523402893758;5311.814086506954;5330.173823057432;5369.4630536946 06:33:44 INFO - PROCESS | 3694 | |5;yui.html;735.6468894930437;743.776866939918;744.8212429017036;746.283567774936;754.230684701604;14343.928280358597;15129.924350378233;15135.091894486339;15181.848181518182;15224.467143649974;13808;14071.085379450355;14089.929550352233;14134.575962721136;14158.50445234417;739.5267029101366;763.4465012865684;779.2013186483842;780.7930898311952;788.9289963903248;788.4402074527064;791.3392317414965;792.0811858244438;792.1642666986327;793.1196372027046;821.8685010398337;822.7202751064636;822.9670813167496;823.2960818500186;823.7611092783086;815.6533473273864;816.5672193737329;817.3175398542224;818.0796603820702;819.7499762572443;592.5970340168726;596.5943158652115;597.1430996519964;597.3966294043005;598.3956204233712;14381.928090359586;14827.555173344708;15577.221138943007;15589.766153507706;15604.843951560566;14881.70236595273;15257.692807387595;15317.923410382988;15331.386744530206;15341.539753807403;11279.37963412012;11622.206486052837;11647.184697071209;11661.416929153509;11934.761304773856;3610.6930910872607;3630.673239408466;3637.217998130415;3677.8344974475945;3716.4982727331735;79477;79509.60245198794;81353.59323203345;82587.58706206491;84052;10837.18721095921;11036.448177591088;11232.943835280772;11392.316461012366;11830.2901825889;22214.555708886055;22549.43626409353;22662.886685566467;22666.60000999863;22667.546649066928;8334.083250842403;8384.83230335402;8386;8753.299736021103;8779.341549383822;4289.678274129453;4358.411614432011;4431.423914891044;4432.556744325541;4585.908281834411;3260.739140868725;3267.950980735291;3277.049655599897;3293.75296852737;3303.801771893694;580.846075789916;581;584.4798129664601;588.5056552495925;639.526750204845;619.4053708439858;653.2879161713755;653.5098675993005;653.6143675231541;656.4387448731361;10354.275200735876;10852.511636976355;11152.382904478805;11200.551977920792;11580.942095289638;728.3117454005913;759.1725019728523;767.493454320146;768.8423873106111;776.3517462918413;4805.062583594511;5176.689398636094;5219.556337711261;5224.164133738584;5266.420693723688;77894.61052694813;78827.60586197033;80910;82361.58819205985;82757.58621206855;40537.79731101326;53840.46159538433;68947.65526172337;69234;70520.2947970524;46987;55382.723086385115;55502.72248638731;55540.16689749657;55973;10742.409167495864;11244.381559014333;11359.716007099889;11402.714932126763;11657.766844663229;36922;41269;41339.1732165349;42047.57952420437;43706.34440483332;53151.468485316196;53691;53856;55293.44706553044;55396.72301638466;13185.208887466782;13252.20486770797;13263.933680331536;13743.656408589864;14099.365528551445;13467.730645387233;13568;14189.07770994882;14348.139111652916;14765.261736912897;13560.660983475493;14078.296085195903;14258.500952466615;15245.771313430529;15266.160361180242;12339.62981110568;13541.260558804339;14279.07186032946;14557.12657240569;14998.550043498712;13315.334233288491;13325.533606323732;13652.658683532594;13833.930830346186;14384.784228236795;10869.945650271698;11091.667249982513;11176.535274065065;11482.196246262682;11739.706507337043;10352.689419317432;11480.947415165216;11657.358845263252;11719.355435451133;11825.172237943605 06:33:44 INFO - PROCESS | 3694 | __end_tp_report 06:33:44 INFO - PROCESS | 3694 | __start_cc_report 06:33:44 INFO - PROCESS | 3694 | _x_x_mozilla_cycle_collect,2110 06:33:44 INFO - PROCESS | 3694 | __end_cc_report 06:33:44 INFO - PROCESS | 3694 | __startTimestamp1486478024295__endTimestamp 06:33:44 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | ------- Summary: start ------- 06:33:44 INFO - PROCESS | 3694 | Number of tests: 6 06:33:44 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | [#0] dojo.html Cycles:165 Average:5298.71 Median:5492.59 stddev:595.48 (10.8%) stddev-sans-first:572.72 06:33:44 INFO - PROCESS | 3694 | Values: 3140.0 3156.5 3188.5 3192.3 3197.9 5240.8 5277.0 5300.3 5337.8 5443.2 5302.8 5304.3 5331.9 5362.0 5380.5 4518.9 4684.5 4875.2 4882.5 4885.9 4699.3 4746.4 4782.9 4846.5 4852.7 4699.3 4736.3 4768.2 4814.7 4846.1 4753.5 4763.7 4770.8 4771.0 4799.5 4699.8 4724.2 4763.9 4778.1 4821.5 5273.4 5275.6 5299.5 5304.1 5371.5 5692.8 5710.4 5711.8 5722.1 5728.1 5743.6 5747.1 5762.7 5764.9 5770.4 5252.9 5289.7 5306.7 5332.1 5406.9 5848.0 5851.6 5854.6 5868.5 5894.8 5475.0 5492.6 5530.0 5530.1 5604.3 5711.5 5712.0 5717.1 5717.5 5719.4 5676.0 5676.4 5685.9 5686.4 5691.9 5690.9 5699.5 5700.2 5701.1 5702.3 4420.3 4427.3 4434.8 4437.9 4528.4 3947.7 3961.4 3988.0 4015.3 4026.2 5435.2 5462.0 5474.8 5485.6 5514.9 5757.5 5762.5 5763.5 5765.4 5774.3 5301.4 5338.4 5453.4 5456.3 5464.3 4886.0 4891.7 4893.3 4930.1 4975.4 5990.0 6000.8 6005.8 6033.3 6056.9 5718.9 5728.3 5728.6 5730.8 5747.3 5815.7 5827.9 5869.6 5967.6 5980.3 5565.6 5600.8 5609.6 5611.8 5623.4 5672.6 5701.2 5705.5 5707.7 5712.1 5500.8 5523.8 5524.8 5531.0 5544.1 5564.6 5569.2 5582.3 5608.2 5622.7 5438.9 5541.4 5547.2 5551.6 5552.0 5491.7 5529.3 5567.9 5588.2 5589.7 5435.6 5447.0 5455.0 5457.8 5491.5 06:33:44 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | [#1] ext.html Cycles:180 Average:55936.77 Median:34664.39 stddev:106445.70 (307.1%) stddev-sans-first:106663.08 06:33:44 INFO - PROCESS | 3694 | Values: 550.9 576.4 584.6 597.9 622.7 41803.0 44291.0 44395.1 47985.0 48222.8 44525.3 44906.6 45237.8 45303.0 45317.5 7627.4 8438.2 8764.3 8767.6 8768.1 7644.6 10701.4 10957.9 10958.7 11247.3 10890.8 10970.7 10974.1 10980.6 10984.6 10723.6 10770.5 10776.7 10783.6 10823.9 10181.1 10295.1 10302.6 10303.7 10303.7 42516.1 42871.4 42887.4 42902.1 42947.8 3948.6 3993.3 3993.5 3995.7 4002.5 30654.9 30717.2 30988.5 31566.7 32258.5 3943.5 3945.1 4007.7 4042.9 4045.2 299724.0 300882.0 300882.0 301019.0 302525.0 50710.0 51815.0 58776.7 59015.0 59020.4 66173.7 66556.3 67585.7 73479.6 74106.0 16294.3 16646.8 16695.2 16700.7 16758.7 12861.9 13123.3 13147.9 13149.7 13161.5 17825.6 17856.9 17916.2 17960.6 18026.5 6057.4 6066.8 6163.3 6207.8 6208.4 893.5 894.2 908.3 908.9 930.3 30590.8 30677.5 30968.4 31059.8 31290.4 1055.9 1081.6 1090.2 1090.8 1093.1 16176.8 16374.5 16436.8 16686.2 16689.9 450620.0 455783.0 456685.0 457343.0 457831.0 62177.0 62231.7 62256.7 62280.7 62377.4 1356.0 1385.6 1393.0 1400.1 1406.6 27721.7 29256.3 29279.4 30250.8 30423.4 52972.7 53452.7 53589.5 53620.0 53625.7 428140.0 432823.0 433878.0 433906.0 436388.0 21801.0 25701.3 26363.3 26625.6 28155.6 39936.2 40030.6 40373.4 40634.0 40817.6 34342.8 34594.5 34817.5 34874.3 35038.1 34349.5 34420.1 34446.7 34459.1 34548.3 34734.3 34823.8 35521.1 35545.6 35834.1 28938.4 30958.5 31014.4 31219.7 31321.4 23656.6 23816.6 23821.9 23876.4 24264.3 06:33:44 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | [#2] jquery.html Cycles:180 Average:32412.17 Median:20815.83 stddev:97005.52 (466.0%) stddev-sans-first:97247.87 06:33:44 INFO - PROCESS | 3694 | Values: 402.3 429.5 433.4 437.5 438.1 18641.6 18718.4 20410.5 20538.7 20655.0 12677.9 19646.4 19680.7 20715.6 20818.0 5783.4 6033.3 6039.8 6040.1 6044.3 5742.4 5873.1 5892.2 6006.5 6013.9 5840.9 5889.6 5900.7 5906.4 5909.6 5638.4 5757.7 5814.6 5827.6 5832.8 5235.8 5293.3 5297.1 5297.4 5297.7 24101.8 24697.4 24876.1 24896.6 25161.5 2669.2 2761.9 2763.2 2785.7 2786.8 9672.0 10534.7 12423.1 14175.3 14470.3 1837.3 1887.6 1955.0 1966.5 1989.3 89383.6 90861.5 91003.5 92302.5 93953.1 11920.3 12078.7 12116.7 12252.9 12386.8 17431.0 17434.7 17444.7 17477.2 17537.0 8309.3 8537.6 8538.1 8632.4 8779.8 8063.0 8064.8 8323.0 8327.4 8336.0 5131.8 5296.5 5308.6 5312.9 5470.7 2182.8 2222.6 2242.1 2270.2 2281.2 832.1 837.2 847.5 855.2 872.5 19304.5 19952.2 20818.3 20833.9 21055.5 847.9 847.9 852.5 857.4 875.5 11326.3 11406.8 11471.8 11522.5 11588.8 569198.0 572396.0 588841.0 609752.8 610978.0 77528.0 83404.0 84088.0 100322.5 103946.0 1003.0 1048.5 1053.6 1066.5 1068.7 17155.9 17514.6 17857.2 18000.0 18122.1 41229.4 42344.6 43863.3 44070.6 45360.8 56290.4 59069.1 59237.0 60719.0 61503.0 8683.0 8930.2 9139.5 9308.0 9323.3 9992.4 11675.1 12076.4 13124.6 13353.0 11223.4 11469.7 11813.0 11826.6 11880.9 11137.8 11160.3 11229.2 11777.0 11840.0 11830.3 12137.4 12177.8 12193.8 12209.5 8645.8 8659.2 8886.5 8959.5 9026.1 11184.4 11321.5 11669.5 11882.6 12126.8 06:33:44 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | [#3] mootools.html Cycles:180 Average:5444.65 Median:4942.32 stddev:3063.11 (62.0%) stddev-sans-first:3056.89 06:33:44 INFO - PROCESS | 3694 | Values: 1436.7 1439.2 1452.1 1457.3 1458.2 8231.2 8684.6 8692.6 8695.0 8701.4 8337.5 8618.7 8648.8 8777.8 8793.3 2166.4 2192.6 2196.4 2198.3 2202.7 2165.6 2194.1 2196.9 2201.0 2220.5 2162.6 2175.1 2186.9 2195.9 2201.5 2049.2 2144.3 2144.4 2155.7 2168.3 2079.0 2168.9 2169.7 2173.8 2174.0 8447.7 8496.2 8513.9 8517.0 8518.1 4912.5 5045.4 5051.1 5052.4 5054.3 2988.5 3173.8 3205.5 3206.8 3233.5 1227.2 1298.3 1300.6 1316.9 1367.7 10417.1 10679.1 10960.7 11523.5 11622.1 4133.5 4247.9 4258.2 4291.7 4317.2 9439.1 9456.3 9457.6 9463.8 9468.1 4277.4 4404.6 4406.3 5038.4 5038.8 4068.9 4573.2 4672.6 4720.3 4753.4 3437.9 3560.3 3568.0 3596.9 3637.3 1065.3 1066.5 1068.6 1075.1 1079.4 770.4 890.7 892.2 896.8 921.7 5417.9 5558.7 5576.5 5619.8 5891.9 1007.8 1013.6 1018.8 1032.2 1048.3 3896.4 3924.6 3987.6 3996.0 4001.5 9958.9 10216.2 10279.0 10284.5 10326.6 9824.6 10090.5 10122.9 10176.4 10198.8 8049.4 8181.6 8187.5 8190.7 8191.3 5543.3 5649.2 5669.3 5702.7 5821.1 9429.1 9462.6 9465.4 9468.5 9573.7 8472.3 8966.4 9301.5 9335.9 9554.0 6309.4 7194.8 7238.9 7239.5 7262.7 7813.2 8059.1 8197.8 8198.1 8221.0 7002.9 7052.4 7054.9 7061.3 7064.4 6956.4 6968.1 7022.6 7059.1 7139.9 6341.1 6527.5 6588.9 6593.8 6594.4 4852.3 4904.6 4917.3 4950.4 5126.0 4934.3 5000.4 5007.6 5021.3 5023.5 06:33:44 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | [#4] prototype.html Cycles:180 Average:4604.00 Median:5178.01 stddev:1324.93 (25.6%) stddev-sans-first:1289.87 06:33:44 INFO - PROCESS | 3694 | Values: 364.7 377.2 384.0 411.2 413.9 4935.9 5084.7 5151.9 5213.2 5217.8 4937.2 5038.0 5144.8 5204.4 5211.1 4067.9 4102.4 4137.8 4147.3 4150.4 3826.2 3942.1 4095.3 4124.6 4131.4 3930.3 4082.1 4088.5 4089.5 4112.5 4028.9 4051.4 4074.6 4080.3 4090.3 3705.6 3709.7 3710.7 3718.8 3724.1 4906.8 4995.6 5011.8 5014.2 5031.3 4749.5 4782.6 4784.5 4786.2 4791.0 5463.5 5464.4 5467.3 5474.9 5498.5 3942.2 4090.6 4109.2 4147.4 4149.7 5660.7 5666.2 5674.7 5676.8 5683.3 4245.9 4255.4 4261.3 4264.3 4264.7 3866.9 4099.0 4119.4 4126.4 4326.3 4600.2 4629.4 4634.0 4687.2 4691.5 5479.5 5484.0 5502.4 5513.5 5519.9 1373.7 1374.5 1390.6 1404.7 1405.7 937.3 955.6 959.8 971.7 972.8 5127.4 5140.4 5148.4 5171.3 5182.9 5397.7 5487.5 5493.3 5496.3 5513.7 4812.6 5089.5 5116.8 5119.5 5173.1 2869.9 2873.0 2874.2 2876.6 2889.5 5555.2 5646.8 5655.0 5667.2 5700.4 5348.4 5486.3 5622.6 5714.7 5733.8 5828.2 5846.5 5860.5 5861.5 5869.5 5461.9 5590.9 5608.5 5614.9 5628.0 5488.9 5525.6 5529.7 5532.5 5535.3 5775.9 5802.3 5814.0 5825.2 5841.8 4039.6 4187.2 4194.1 4251.6 4265.3 5411.5 5472.5 5567.4 5583.4 5584.5 5422.6 5434.6 5444.0 5446.5 5447.3 5200.1 5385.9 5418.2 5430.6 5440.6 5391.8 5408.2 5438.7 5447.3 5447.5 5455.2 5489.8 5509.3 5516.6 5519.1 4984.3 5295.5 5311.8 5330.2 5369.5 06:33:44 INFO - PROCESS | 3694 | 06:33:44 INFO - PROCESS | 3694 | [#5] yui.html Cycles:180 Average:17304.38 Median:22127.15 stddev:21785.17 (98.5%) stddev-sans-first:21810.75 06:33:44 INFO - PROCESS | 3694 | Values: 735.6 743.8 744.8 746.3 754.2 14343.9 15129.9 15135.1 15181.8 15224.5 13808.0 14071.1 14089.9 14134.6 14158.5 739.5 763.4 779.2 780.8 788.9 788.4 791.3 792.1 792.2 793.1 821.9 822.7 823.0 823.3 823.8 815.7 816.6 817.3 818.1 819.7 592.6 596.6 597.1 597.4 598.4 14381.9 14827.6 15577.2 15589.8 15604.8 14881.7 15257.7 15317.9 15331.4 15341.5 11279.4 11622.2 11647.2 11661.4 11934.8 3610.7 3630.7 3637.2 3677.8 3716.5 79477.0 79509.6 81353.6 82587.6 84052.0 10837.2 11036.4 11232.9 11392.3 11830.3 22214.6 22549.4 22662.9 22666.6 22667.5 8334.1 8384.8 8386.0 8753.3 8779.3 4289.7 4358.4 4431.4 4432.6 4585.9 3260.7 3268.0 3277.0 3293.8 3303.8 580.8 581.0 584.5 588.5 639.5 619.4 653.3 653.5 653.6 656.4 10354.3 10852.5 11152.4 11200.6 11580.9 728.3 759.2 767.5 768.8 776.4 4805.1 5176.7 5219.6 5224.2 5266.4 77894.6 78827.6 80910.0 82361.6 82757.6 40537.8 53840.5 68947.7 69234.0 70520.3 46987.0 55382.7 55502.7 55540.2 55973.0 10742.4 11244.4 11359.7 11402.7 11657.8 36922.0 41269.0 41339.2 42047.6 43706.3 53151.5 53691.0 53856.0 55293.4 55396.7 13185.2 13252.2 13263.9 13743.7 14099.4 13467.7 13568.0 14189.1 14348.1 14765.3 13560.7 14078.3 14258.5 15245.8 15266.2 12339.6 13541.3 14279.1 14557.1 14998.6 13315.3 13325.5 13652.7 13833.9 14384.8 10869.9 11091.7 11176.5 11482.2 11739.7 10352.7 11480.9 11657.4 11719.4 11825.2 06:33:44 INFO - PROCESS | 3694 | -------- Summary: end -------- 06:33:44 INFO - PROCESS | 3694 | 06:33:45 INFO - TEST-INFO | 3694: exit 0 06:33:45 INFO - TEST-OK | dromaeo_css | took 1116874ms 06:33:45 INFO - TEST-START | kraken 06:33:45 INFO - operating with platform_type : linux_ 06:33:45 INFO - Initialising browser for kraken test... 06:33:45 INFO - TEST-INFO | started process 4000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIihi7o/profile http://localhost:37402/getInfo.html) 06:33:48 INFO - PROCESS | 4000 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 06:33:49 INFO - PROCESS | 4000 | __metrics Screen width/height:1600/1200 06:33:49 INFO - PROCESS | 4000 | colorDepth:24 06:33:49 INFO - PROCESS | 4000 | Browser inner width/height: 1024/697 06:33:49 INFO - PROCESS | 4000 | __metrics 06:33:50 INFO - PROCESS | 4000 | 1486478030068 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 06:33:50 INFO - PROCESS | 4000 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:33:50 INFO - PROCESS | 4000 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:33:51 INFO - TEST-INFO | 4000: exit 0 06:33:51 INFO - Browser initialized. 06:33:51 INFO - Running cycle 1/1 for kraken test... 06:33:51 INFO - TEST-INFO | started process 4087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIihi7o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:03 INFO - PROCESS | 4087 | RSS: Main: 152940544 06:34:03 INFO - PROCESS | 4087 | 06:34:05 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37402/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:06 INFO - PROCESS | 4087 | RSS: Main: 204644352 06:34:06 INFO - PROCESS | 4087 | 06:34:09 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37402/tests/kraken/driver.html?testName=audio-dft) 06:34:09 INFO - PROCESS | 4087 | RSS: Main: 183656448 06:34:09 INFO - PROCESS | 4087 | 06:34:12 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37402/tests/kraken/driver.html?testName=audio-fft) 06:34:13 INFO - PROCESS | 4087 | RSS: Main: 265388032 06:34:13 INFO - PROCESS | 4087 | 06:34:15 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37402/tests/kraken/driver.html?testName=audio-oscillator) 06:34:16 INFO - PROCESS | 4087 | RSS: Main: 176025600 06:34:16 INFO - PROCESS | 4087 | 06:34:18 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37402/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:18 INFO - PROCESS | 4087 | RSS: Main: 181071872 06:34:18 INFO - PROCESS | 4087 | 06:34:21 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37402/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:22 INFO - PROCESS | 4087 | RSS: Main: 219963392 06:34:22 INFO - PROCESS | 4087 | 06:34:25 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37402/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:26 INFO - PROCESS | 4087 | RSS: Main: 220364800 06:34:26 INFO - PROCESS | 4087 | 06:34:29 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37402/tests/kraken/driver.html?testName=json-parse-financial) 06:34:29 INFO - PROCESS | 4087 | RSS: Main: 219004928 06:34:29 INFO - PROCESS | 4087 | 06:34:31 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37402/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:31 INFO - PROCESS | 4087 | RSS: Main: 180547584 06:34:31 INFO - PROCESS | 4087 | 06:34:33 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37402/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:34 INFO - PROCESS | 4087 | RSS: Main: 188309504 06:34:34 INFO - PROCESS | 4087 | 06:34:36 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37402/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:37 INFO - PROCESS | 4087 | RSS: Main: 196603904 06:34:37 INFO - PROCESS | 4087 | 06:34:39 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:40 INFO - PROCESS | 4087 | RSS: Main: 205406208 06:34:40 INFO - PROCESS | 4087 | 06:34:43 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:34:43 INFO - PROCESS | 4087 | RSS: Main: 202022912 06:34:43 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | Cycle 1(1): loaded http://localhost:37402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37402/tests/kraken/driver.html?testName=ai-astar) 06:34:45 INFO - PROCESS | 4087 | RSS: Main: 253792256 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | __start_tp_report 06:34:45 INFO - PROCESS | 4087 | _x_x_mozilla_page_load 06:34:45 INFO - PROCESS | 4087 | _x_x_mozilla_page_load_details 06:34:45 INFO - PROCESS | 4087 | |i|pagename|runs| 06:34:45 INFO - PROCESS | 4087 | |0;ai-astar;111;111;111;113;111;111;110;111;111;110 06:34:45 INFO - PROCESS | 4087 | |1;audio-beat-detection;144;121;118;178;126;118;120;118;153;123 06:34:45 INFO - PROCESS | 4087 | |2;audio-dft;162;162;161;161;161;162;162;161;162;162 06:34:45 INFO - PROCESS | 4087 | |3;audio-fft;75;76;76;107;77;76;77;75;113;75 06:34:45 INFO - PROCESS | 4087 | |4;audio-oscillator;83;82;105;83;82;83;94;82;83;109 06:34:45 INFO - PROCESS | 4087 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 06:34:45 INFO - PROCESS | 4087 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;147;147 06:34:45 INFO - PROCESS | 4087 | |7;imaging-desaturate;95;96;96;96;96;96;95;96;96;95 06:34:45 INFO - PROCESS | 4087 | |8;json-parse-financial;55;53;52;54;53;54;53;54;53;54 06:34:45 INFO - PROCESS | 4087 | |9;json-stringify-tinderbox;62;63;61;62;63;63;63;62;63;63 06:34:45 INFO - PROCESS | 4087 | |10;stanford-crypto-aes;83;86;84;82;84;85;82;83;82;82 06:34:45 INFO - PROCESS | 4087 | |11;stanford-crypto-ccm;127;126;132;125;131;127;127;136;164;136 06:34:45 INFO - PROCESS | 4087 | |12;stanford-crypto-pbkdf2;167;168;164;165;165;164;164;179;170;165 06:34:45 INFO - PROCESS | 4087 | |13;stanford-crypto-sha256-iterative;63;61;61;62;61;61;61;64;60;61 06:34:45 INFO - PROCESS | 4087 | __end_tp_report 06:34:45 INFO - PROCESS | 4087 | __start_cc_report 06:34:45 INFO - PROCESS | 4087 | _x_x_mozilla_cycle_collect,1730 06:34:45 INFO - PROCESS | 4087 | __end_cc_report 06:34:45 INFO - PROCESS | 4087 | __startTimestamp1486478085630__endTimestamp 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | ------- Summary: start ------- 06:34:45 INFO - PROCESS | 4087 | Number of tests: 14 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 06:34:45 INFO - PROCESS | 4087 | Values: 111.0 111.0 111.0 113.0 111.0 111.0 110.0 111.0 111.0 110.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:124.50 stddev:20.20 (16.2%) stddev-sans-first:20.94 06:34:45 INFO - PROCESS | 4087 | Values: 144.0 121.0 118.0 178.0 126.0 118.0 120.0 118.0 153.0 123.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:34:45 INFO - PROCESS | 4087 | Values: 162.0 162.0 161.0 161.0 161.0 162.0 162.0 161.0 162.0 162.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.48 (19.0%) stddev-sans-first:15.08 06:34:45 INFO - PROCESS | 4087 | Values: 75.0 76.0 76.0 107.0 77.0 76.0 77.0 75.0 113.0 75.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:83.00 stddev:10.38 (12.5%) stddev-sans-first:10.81 06:34:45 INFO - PROCESS | 4087 | Values: 83.0 82.0 105.0 83.0 82.0 83.0 94.0 82.0 83.0 109.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:34:45 INFO - PROCESS | 4087 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:34:45 INFO - PROCESS | 4087 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 06:34:45 INFO - PROCESS | 4087 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.85 (1.6%) stddev-sans-first:0.71 06:34:45 INFO - PROCESS | 4087 | Values: 55.0 53.0 52.0 54.0 53.0 54.0 53.0 54.0 53.0 54.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 06:34:45 INFO - PROCESS | 4087 | Values: 62.0 63.0 61.0 62.0 63.0 63.0 63.0 62.0 63.0 63.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:1.42 (1.7%) stddev-sans-first:1.50 06:34:45 INFO - PROCESS | 4087 | Values: 83.0 86.0 84.0 82.0 84.0 85.0 82.0 83.0 82.0 82.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:131.50 stddev:11.57 (8.8%) stddev-sans-first:12.06 06:34:45 INFO - PROCESS | 4087 | Values: 127.0 126.0 132.0 125.0 131.0 127.0 127.0 136.0 164.0 136.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:166.00 stddev:4.63 (2.8%) stddev-sans-first:4.91 06:34:45 INFO - PROCESS | 4087 | Values: 167.0 168.0 164.0 165.0 165.0 164.0 164.0 179.0 170.0 165.0 06:34:45 INFO - PROCESS | 4087 | 06:34:45 INFO - PROCESS | 4087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.00 stddev:1.18 (1.9%) stddev-sans-first:1.12 06:34:45 INFO - PROCESS | 4087 | Values: 63.0 61.0 61.0 62.0 61.0 61.0 61.0 64.0 60.0 61.0 06:34:45 INFO - PROCESS | 4087 | -------- Summary: end -------- 06:34:45 INFO - PROCESS | 4087 | 06:34:46 INFO - TEST-INFO | 4087: exit 0 06:34:46 INFO - TEST-OK | kraken | took 61583ms 06:34:46 INFO - SUITE-END | took 1178s 06:34:46 INFO - Completed test suite (00:19:38) 06:34:46 INFO - javascript benchmark 06:34:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7122.43483208984, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.9843000784995, 3156.5107408351714, 3188.4739018062005, 3192.26577887086, 3197.888073917412, 5240.842774716755, 5276.973615131924, 5300.337457817773, 5337.813176538822, 5443.156310771837, 5302.814401495948, 5304.336957880265, 5331.866703332418, 5362.034833729927, 5380.542653874425, 4518.864434066967, 4684.531546845323, 4875.24433712775, 4882.536159064901, 4885.8778530536665, 4699.271612900006, 4746.430428348603, 4782.856514304576, 4846.515348465161, 4852.684575502599, 4699.271612900006, 4736.313234581001, 4768.189407800647, 4814.7351895645725, 4846.103470857903, 4753.548412900769, 4763.7141771493825, 4770.76146192689, 4770.95229047712, 4799.544043315915, 4699.835505757282, 4724.196886529298, 4763.928541071887, 4778.139934811733, 4821.493743156988, 5273.393559740641, 5275.57795376369, 5299.496547827989, 5304.071787437183, 5371.4897084776885, 5692.800751973661, 5710.371859095496, 5711.8000869969355, 5722.113072473773, 5728.083506638918, 5743.62666426681, 5747.109198074305, 5762.683052432115, 5764.855878603026, 5770.365259821417, 5252.894942101175, 5289.656172348824, 5306.708131052829, 5332.093544097513, 5406.864828379244, 5847.970760146172, 5851.561132915049, 5854.560907931922, 5868.501177399883, 5894.764209431661, 5475.0, 5492.588055895744, 5530.0, 5530.11518157101, 5604.32748070226, 5711.543076553949, 5711.971440142773, 5717.085266357363, 5717.456841600041, 5719.370869204384, 5676.035074037423, 5676.432356764373, 5685.857853553694, 5686.3744988051285, 5691.9146212806845, 5690.886182276414, 5699.5155411790465, 5700.173474846207, 5701.087825947829, 5702.287214098238, 4420.292753159543, 4427.335899615084, 4434.822607095744, 4437.911241775211, 4528.366028755977, 3947.684185265172, 3961.3859851723028, 3988.0428697112484, 4015.3374693175297, 4026.154507553388, 5435.239066530688, 5462.044142275086, 5474.753636086386, 5485.588580856452, 5514.944850551524, 5757.539396848326, 5762.510186634099, 5763.538916886639, 5765.423457654201, 5774.3070831499645, 5301.443348448357, 5338.439463856317, 5453.372862120907, 5456.290682211287, 5464.26232458621, 4886.047220791911, 4891.706497610155, 4893.266010098514, 4930.137225985438, 4975.353204083446, 5990.041593345044, 6000.819975400745, 6005.849853753691, 6033.306169790442, 6056.878862422727, 5718.914216286676, 5728.283964504437, 5728.570357223141, 5730.828075157752, 5747.3103227612955, 5815.651060936358, 5827.854303642273, 5869.618474799125, 5967.6419414835245, 5980.312264089685, 5565.6104072714525, 5600.831975040755, 5609.607327487037, 5611.80358687444, 5623.437656234344, 5672.5745569081655, 5701.230333904869, 5705.4579814917515, 5707.6575405475805, 5712.11462223356, 5500.752466138953, 5523.751431185687, 5524.779008839601, 5531.03206938776, 5544.0575102231915, 5564.582656300713, 5569.248151499658, 5582.302212223472, 5608.186812912187, 5622.746976385991, 5438.945610543844, 5541.445855414427, 5547.223388725501, 5551.611387202857, 5552.028395030773, 5491.725413729378, 5529.253550770594, 5567.8608034797835, 5588.16177573351, 5589.664620122806, 5435.592330575144, 5447.0, 5454.9727251365075, 5457.754401052041, 5491.533219676372], "value": 5259.737084703162, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.8843142939983, 576.3832699012058, 584.6053913608313, 597.8624916269258, 622.7384498510625, 41803.0, 44291.0, 44395.112097758065, 47985.0, 48222.75888620552, 44525.332120018225, 44906.550934490646, 45237.77381113098, 45303.0, 45317.546824531746, 7627.427942904276, 8438.156184381543, 8764.298856091498, 8767.649294028231, 8768.123187681245, 7644.61776911155, 10701.357918524913, 10957.890421095806, 10958.671239862817, 11247.325160490356, 10890.782184356309, 10970.725731856688, 10974.122070234402, 10980.615678451215, 10984.615538456155, 10723.624673136403, 10770.515326810313, 10776.73058173548, 10783.62257320998, 10823.945880270627, 10181.134603558632, 10295.073443390056, 10302.639407620698, 10303.690889273334, 10303.690889273334, 42516.14967700659, 42871.35692964577, 42887.35668964968, 42902.14195716068, 42947.785261073805, 3948.624880636335, 3993.28120938231, 3993.4608827808456, 3995.700322475826, 4002.4990628514306, 30654.90521174108, 30717.23206919845, 30988.53517197244, 31566.684333156834, 32258.516122258185, 3943.4676318696897, 3945.0729078666777, 4007.73949693269, 4042.8787136385954, 4045.19096180765, 299724.0, 300882.0, 300882.0, 301019.0, 302525.0, 50710.0, 51815.0, 58776.70611646914, 59015.0, 59020.40979590149, 66173.66913165404, 66556.33443665598, 67585.66207168932, 73479.63260183771, 74106.0, 16294.266757995918, 16646.75029874553, 16695.24871380791, 16700.66598668044, 16758.74861877073, 12861.935690321488, 13123.343832808321, 13147.934260328637, 13149.737005259842, 13161.53934612303, 17825.643487130445, 17856.910715446338, 17916.193771280323, 17960.640787184184, 18026.549336266435, 6057.42454466825, 6066.757329706762, 6163.322034576193, 6207.782727604603, 6208.410201030985, 893.5041052215953, 894.2488309819782, 908.3051465628799, 908.8500397434349, 930.3069213435898, 30590.84704576463, 30677.539836902466, 30968.380632387678, 31059.84470077635, 31290.37419251602, 1055.9313644613076, 1081.605214096849, 1090.1823632275793, 1090.8200146975819, 1093.1145771924766, 16176.838231617534, 16374.508764737076, 16436.75344869828, 16686.249118789685, 16689.91655041717, 450620.0, 455783.0, 456685.0, 457343.0, 457831.0, 62177.0, 62231.6888415555, 62256.68871655703, 62280.68859655673, 62377.37622623716, 1355.9728805423836, 1385.5843247025853, 1392.997042129665, 1400.0619584877952, 1406.5512522102251, 27721.722782772722, 29256.26859328534, 29279.414411712074, 30250.84874575613, 30423.391532169677, 52972.735136324074, 53452.73273633607, 53589.464105360006, 53620.0, 53625.731871340395, 428140.0, 432823.0, 433878.0, 433906.0, 436388.0, 21801.0, 25701.329413588057, 26363.340916477242, 26625.600615991163, 28155.57766633543, 39936.2012759749, 40030.59969400269, 40373.39439908345, 40634.0, 40817.59182408138, 34342.82828585841, 34594.48108278328, 34817.47773783345, 34874.30251395009, 35038.12404689903, 34349.484757728154, 34420.13949651279, 34446.65553344435, 34459.13852153616, 34548.309033819685, 34734.30531389409, 34823.825880870434, 35521.11197219987, 35545.644543554234, 35834.10414739652, 28938.42123157567, 30958.53562196614, 31014.379712406077, 31219.687803121677, 31321.37357252888, 23656.645150322416, 23816.624855989983, 23821.880890595436, 23876.40308992289, 24264.272071837873], "value": 19592.819913645202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.2718878829321, 429.5466748485081, 433.4430257119601, 437.52965562020836, 438.08003193294087, 18641.62716745664, 18718.438446846583, 20410.489737756565, 20538.69191962122, 20655.0, 12677.873221267784, 19646.410607681755, 19680.704789428135, 20715.585688286224, 20818.0, 5783.392743761908, 6033.276006879159, 6039.788607398742, 6040.0939859021055, 6044.335123136451, 5742.425757424245, 5873.148393482942, 5892.175095486636, 6006.459418652343, 6013.879722405549, 5840.912386314209, 5889.6171748836405, 5900.704964751767, 5906.438888305604, 5909.6158749681135, 5638.379778224392, 5757.712114394305, 5814.622049566765, 5827.562932780037, 5832.825015249549, 5235.816746413895, 5293.311869456985, 5297.12597421425, 5297.364316282033, 5297.735113244361, 24101.7589824103, 24697.38256543583, 24876.129335473353, 24896.626550601755, 25161.496770064678, 2669.225924481898, 2761.9171424857286, 2763.1710486853863, 2785.7214278571983, 2786.7770578353684, 9672.0, 10534.683959481228, 12423.130380873343, 14175.291235438186, 14470.348834302482, 1837.3110083718605, 1887.5752955585021, 1954.99022504888, 1966.5083729067733, 1989.254029738848, 89383.55308223482, 90861.54569227177, 91003.54498227533, 92302.5384873078, 93953.06046939512, 11920.284782913053, 12078.698032549257, 12116.698572006811, 12252.877471225353, 12386.81419778704, 17431.0, 17434.65130697379, 17444.738328925076, 17477.213525391388, 17537.0, 8309.25216730485, 8537.573121343908, 8538.103499132501, 8632.35257355701, 8779.780505487413, 8063.0, 8064.83870322602, 8323.0, 8327.417080804407, 8335.958005249344, 5131.820386286537, 5296.4968328009545, 5308.575313974873, 5312.867178320495, 5470.699111548824, 2182.8035476807163, 2222.622154233784, 2242.1367773407355, 2270.1600407848873, 2281.1559722902634, 832.1137988042715, 837.2046555772041, 847.4914651919593, 855.2003876375609, 872.4547158026234, 19304.517387065436, 19952.20191192365, 20818.27136050231, 20833.87053584716, 21055.473613159487, 847.8685803700437, 847.877057826624, 852.497026754218, 857.4298091768903, 875.4659657608853, 11326.263792853602, 11406.771864562828, 11471.827922581168, 11522.53909843597, 11588.76822463546, 569198.0, 572396.0, 588841.0, 609752.756181099, 610978.0, 77528.0, 83404.0, 84088.0, 100322.4983875076, 103946.0, 1002.9899701002896, 1048.5386429970788, 1053.5838343854289, 1066.4827558634056, 1068.7274744940146, 17155.91422042882, 17514.562135946704, 17857.196426160594, 18000.0, 18122.09389530492, 41229.38155927724, 42344.57655423407, 43863.34204986864, 44070.559294407925, 45360.77319613381, 56290.43709562852, 59069.113963289725, 59237.0, 60719.0, 61503.0, 8683.0, 8930.19628233462, 9139.522123010871, 9308.0, 9323.254139668947, 9992.400455972665, 11675.065994720571, 12076.396180191132, 13124.606261812161, 13353.0, 11223.438828058728, 11469.655910322703, 11813.0, 11826.645200643994, 11880.881191188324, 11137.832932505857, 11160.330380177214, 11229.21395502307, 11776.997910355089, 11840.0, 11830.349330786545, 12137.393130343271, 12177.817332739838, 12193.756124877631, 12209.450574723982, 8645.827083458422, 8659.177378149066, 8886.4668119913, 8959.462432254086, 9026.097390261184, 11184.440777961232, 11321.528201333775, 11669.533218671497, 11882.584109556125, 12126.75746485083], "value": 9571.625675798285, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.6623843396806, 1439.2156274830215, 1452.070674768148, 1457.2932127917961, 1458.161557104665, 8231.218034286741, 8684.609192586333, 8692.608832602533, 8695.043545210021, 8701.434406763556, 8337.541435221076, 8618.741437756877, 8648.827023459527, 8777.780555486115, 8793.2965362771, 2166.3825809644295, 2192.583409152264, 2196.374033400481, 2198.3075331270597, 2202.7466841313294, 2165.588538177741, 2194.1442837293466, 2196.901139448729, 2201.0, 2220.478187625915, 2162.610730068587, 2175.1299480207963, 2186.8687878727246, 2195.901184446696, 2201.471646804763, 2049.231538173185, 2144.3031014920134, 2144.431725592719, 2155.741311042685, 2168.2519530761783, 2079.0, 2168.8698678079368, 2169.6853956176424, 2173.836962227839, 2173.9999600183933, 8447.662093516252, 8496.235338819535, 8513.914860851373, 8517.0, 8518.105598912087, 4912.459629440795, 5045.445001049881, 5051.116054690415, 5052.368453943257, 5054.267131265982, 2988.4620768261702, 3173.841307934617, 3205.4550726376574, 3206.8236247006407, 3233.4826427771677, 1227.1593958138615, 1298.3118946958127, 1300.5903140510804, 1316.9012324075636, 1367.7401293754156, 10417.114545263586, 10679.145668346591, 10960.671179864617, 11523.48144333507, 11622.07023438123, 4133.4626498555, 4247.87256382309, 4258.233517966796, 4291.742495450283, 4317.201317756225, 9439.056094390506, 9456.290778191664, 9457.621695132118, 9463.763405914908, 9468.14786669203, 4277.443932288845, 4404.647628189737, 4406.25093734066, 5038.420581633159, 5038.798448062036, 4068.8575899843954, 4573.199690054227, 4672.626189904868, 4720.315554244684, 4753.35829662998, 3437.914052148716, 3560.2523470071574, 3567.982160089183, 3596.892093237207, 3637.308911306843, 1065.3235195650664, 1066.4987455895716, 1068.5672302717412, 1075.1452595186688, 1079.3739631013993, 770.4029377232689, 890.7238755985666, 892.1524551675934, 896.7982204004178, 921.7050543826045, 5417.864553386197, 5558.6942718150085, 5576.498115169654, 5619.831405057773, 5891.882461431116, 1007.7531004903846, 1013.554036224059, 1018.7707765752795, 1032.1587905856852, 1048.3028785857473, 3896.357101078347, 3924.6271604197555, 3987.6211759882763, 3996.0, 4001.4998125234347, 9958.850617240747, 10216.1827053837, 10278.972102789661, 10284.485775711184, 10326.586936522455, 9824.607015719434, 10090.49547522621, 10122.949385253027, 10176.440295783656, 10198.796024079476, 8049.436539442183, 8181.590920453954, 8187.5087494750505, 8190.672373105009, 8191.303739182117, 5543.307086614173, 5649.237352957298, 5669.34802497718, 5702.657840529581, 5821.126830975388, 9429.104235097655, 9462.621495140118, 9465.384749991228, 9468.47923364194, 9573.712788616353, 8472.322214222724, 8966.372353935161, 9301.534923253945, 9335.906640933776, 9553.952230238805, 6309.432151106423, 7194.820129496805, 7238.927610724036, 7239.4932354734665, 7262.709491620276, 7813.1796161402235, 8059.113497515152, 8197.754067377988, 8198.139195384638, 8220.958895205486, 7002.894956575554, 7052.400545953651, 7054.858902822018, 7061.2938706131035, 7064.364207221375, 6956.443484521327, 6968.0941477607585, 7022.613756243456, 7059.117610298713, 7139.928600713926, 6341.112244285711, 6527.477801775752, 6588.868222635616, 6593.80218593443, 6594.439472644879, 4852.344933434082, 4904.58311043551, 4917.28699338601, 4950.381202349707, 5125.974370128126, 4934.259861020875, 5000.449950505369, 5007.599392048554, 5021.347224860745, 5023.547880690755], "value": 4378.783365368991, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.6991232233408, 377.1965713031243, 384.03798484795584, 411.18995578709934, 413.86963106621414, 4935.876603084916, 5084.694948283617, 5151.948480515193, 5213.244079608459, 5217.817376391822, 4937.185364414876, 5038.0, 5144.845654630358, 5204.375474943012, 5211.114110601197, 4067.9220006698247, 4102.384642303648, 4137.793110344486, 4147.278879265102, 4150.418941348214, 3826.196498735269, 3942.0933185367385, 4095.28332541804, 4124.649404800595, 4131.35963925592, 3930.2925473414775, 4082.0815316553835, 4088.4684990951137, 4089.5297040840237, 4112.465379500676, 4028.8517772435007, 4051.4125451809323, 4074.5721699221453, 4080.326746086892, 4090.3046482097966, 3705.555333359987, 3709.7217708671956, 3710.684591809699, 3718.7954662493553, 3724.1248306647917, 4906.828261010884, 4995.625328100407, 5011.774470148852, 5014.197728363444, 5031.345925029759, 4749.548792864673, 4782.569568738795, 4784.473707892129, 4786.162421576245, 4790.952090479121, 5463.508284254396, 5464.426235245322, 5467.316585426822, 5474.945250547484, 5498.51540084179, 3942.172143849795, 4090.550039495653, 4109.239790638741, 4147.357159640261, 4149.65544467378, 5660.697869619078, 5666.235058267122, 5674.659520428746, 5676.772929082832, 5683.318001839764, 4245.8513952012145, 4255.3616957456625, 4261.339492378686, 4264.275073237495, 4264.744115353089, 3866.9226615467533, 4098.959010409858, 4119.361498967664, 4126.360414135814, 4326.307790753464, 4600.159936025617, 4629.375034370384, 4633.976830115896, 4687.179743544934, 4691.46048204454, 5479.4520547944885, 5484.0, 5502.394736578973, 5513.5037846594, 5519.902437073966, 1373.6703191234033, 1374.5257886029303, 1390.5897760160776, 1404.6699025728944, 1405.6977749783846, 937.3485427627869, 955.603424578806, 959.8080383923243, 971.6987733802544, 972.8443449048118, 5127.384713834289, 5140.383154021467, 5148.382194136728, 5171.29347315385, 5182.922256166161, 5397.70312632809, 5487.518370040067, 5493.285872836585, 5496.340439147328, 5513.696746678971, 4812.614990800727, 5089.491050894881, 5116.769745361467, 5119.462456442095, 5173.094708426011, 2869.9282517937218, 2872.9513727489316, 2874.195225336909, 2876.5541341091744, 2889.5232286672463, 5555.166724991283, 5646.774129034875, 5654.971725141348, 5667.1782591524, 5700.429957004267, 5348.411674715778, 5486.286782718301, 5622.550195984311, 5714.7428365723645, 5733.799317023884, 5828.213191219131, 5846.473817356458, 5860.501857342174, 5861.472467477947, 5869.530437564985, 5461.9453805461435, 5590.86022849432, 5608.46719561641, 5614.943850561442, 5627.971860140673, 5488.898772193857, 5525.585581081516, 5529.723513824373, 5532.529734972572, 5535.308086489189, 5775.9133612995, 5802.274715660543, 5813.970930145322, 5825.184474173534, 5841.824745257649, 4039.636432721069, 4187.162567486575, 4194.118113986362, 4251.5748425157235, 4265.317549192115, 5411.485908838654, 5472.510007946455, 5567.387587365468, 5583.413741557078, 5584.548017515556, 5422.593305502024, 5434.581611182985, 5443.972780136232, 5446.455354464681, 5447.319085114361, 5200.093124167213, 5385.946140538545, 5418.187271909087, 5430.647007944471, 5440.591955603267, 5391.75737091824, 5408.188771684278, 5438.673679579238, 5447.291852059207, 5447.4824891635235, 5455.1544510600925, 5489.807856724996, 5509.264581656766, 5516.586256030733, 5519.123498010696, 4984.302197692398, 5295.523402893758, 5311.814086506954, 5330.173823057432, 5369.4630536946], "value": 4198.728591729223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.6468894930437, 743.776866939918, 744.8212429017036, 746.283567774936, 754.230684701604, 14343.928280358597, 15129.924350378233, 15135.091894486339, 15181.848181518182, 15224.467143649974, 13808.0, 14071.085379450355, 14089.929550352233, 14134.575962721136, 14158.50445234417, 739.5267029101366, 763.4465012865684, 779.2013186483842, 780.7930898311952, 788.9289963903248, 788.4402074527064, 791.3392317414965, 792.0811858244438, 792.1642666986327, 793.1196372027046, 821.8685010398337, 822.7202751064636, 822.9670813167496, 823.2960818500186, 823.7611092783086, 815.6533473273864, 816.5672193737329, 817.3175398542224, 818.0796603820702, 819.7499762572443, 592.5970340168726, 596.5943158652115, 597.1430996519964, 597.3966294043005, 598.3956204233712, 14381.928090359586, 14827.555173344708, 15577.221138943007, 15589.766153507706, 15604.843951560566, 14881.70236595273, 15257.692807387595, 15317.923410382988, 15331.386744530206, 15341.539753807403, 11279.37963412012, 11622.206486052837, 11647.184697071209, 11661.416929153509, 11934.761304773856, 3610.6930910872607, 3630.673239408466, 3637.217998130415, 3677.8344974475945, 3716.4982727331735, 79477.0, 79509.60245198794, 81353.59323203345, 82587.58706206491, 84052.0, 10837.18721095921, 11036.448177591088, 11232.943835280772, 11392.316461012366, 11830.2901825889, 22214.555708886055, 22549.43626409353, 22662.886685566467, 22666.60000999863, 22667.546649066928, 8334.083250842403, 8384.83230335402, 8386.0, 8753.299736021103, 8779.341549383822, 4289.678274129453, 4358.411614432011, 4431.423914891044, 4432.556744325541, 4585.908281834411, 3260.739140868725, 3267.950980735291, 3277.049655599897, 3293.75296852737, 3303.801771893694, 580.846075789916, 581.0, 584.4798129664601, 588.5056552495925, 639.526750204845, 619.4053708439858, 653.2879161713755, 653.5098675993005, 653.6143675231541, 656.4387448731361, 10354.275200735876, 10852.511636976355, 11152.382904478805, 11200.551977920792, 11580.942095289638, 728.3117454005913, 759.1725019728523, 767.493454320146, 768.8423873106111, 776.3517462918413, 4805.062583594511, 5176.689398636094, 5219.556337711261, 5224.164133738584, 5266.420693723688, 77894.61052694813, 78827.60586197033, 80910.0, 82361.58819205985, 82757.58621206855, 40537.79731101326, 53840.46159538433, 68947.65526172337, 69234.0, 70520.2947970524, 46987.0, 55382.723086385115, 55502.72248638731, 55540.16689749657, 55973.0, 10742.409167495864, 11244.381559014333, 11359.716007099889, 11402.714932126763, 11657.766844663229, 36922.0, 41269.0, 41339.1732165349, 42047.57952420437, 43706.34440483332, 53151.468485316196, 53691.0, 53856.0, 55293.44706553044, 55396.72301638466, 13185.208887466782, 13252.20486770797, 13263.933680331536, 13743.656408589864, 14099.365528551445, 13467.730645387233, 13568.0, 14189.07770994882, 14348.139111652916, 14765.261736912897, 13560.660983475493, 14078.296085195903, 14258.500952466615, 15245.771313430529, 15266.160361180242, 12339.62981110568, 13541.260558804339, 14279.07186032946, 14557.12657240569, 14998.550043498712, 13315.334233288491, 13325.533606323732, 13652.658683532594, 13833.930830346186, 14384.784228236795, 10869.945650271698, 11091.667249982513, 11176.535274065065, 11482.196246262682, 11739.706507337043, 10352.689419317432, 11480.947415165216, 11657.358845263252, 11719.355435451133, 11825.172237943605], "value": 7197.899192507366, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1495.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 113.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 118.0, 178.0, 126.0, 118.0, 120.0, 118.0, 153.0, 123.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 107.0, 77.0, 76.0, 77.0, 75.0, 113.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 105.0, 83.0, 82.0, 83.0, 94.0, 82.0, 83.0, 109.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 54.0, 53.0, 54.0, 53.0, 54.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 82.0, 84.0, 85.0, 82.0, 83.0, 82.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 132.0, 125.0, 131.0, 127.0, 127.0, 136.0, 164.0, 136.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 164.0, 165.0, 165.0, 164.0, 164.0, 179.0, 170.0, 165.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 64.0, 60.0, 61.0], "value": 61.5, "unit": "score"}]}]} 06:34:46 INFO - Return code: 0 06:34:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:34:46 ERROR - # TBPL SUCCESS # 06:34:46 INFO - Running post-action listener: _resource_record_post_action 06:34:46 INFO - [mozharness: 2017-02-07 14:34:46.958600Z] Finished run-tests step (success) 06:34:46 INFO - Running post-run listener: _resource_record_post_run 06:34:47 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 400424960; Read time: 0; Write time: 495560 06:34:47 INFO - TinderboxPrint: CPU usage
13.0% 06:34:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:34:47 INFO - TinderboxPrint: I/O write bytes / time
400,424,960 / 495,560 06:34:47 INFO - TinderboxPrint: CPU idle
8,299.6 (86.9%) 06:34:47 INFO - TinderboxPrint: CPU user
1,197.0 (12.5%) 06:34:47 INFO - TinderboxPrint: Swap in / out
0 / 0 06:34:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105603072; Read time: 0; Write time: 125628 06:34:47 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 294625280; Read time: 0; Write time: 369900 06:34:47 INFO - Running post-run listener: _upload_blobber_files 06:34:47 INFO - Blob upload gear active. 06:34:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:34:47 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 06:34:47 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:34:47 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:34:48 INFO - (blobuploader) - INFO - Open directory for files ... 06:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:34:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:52 INFO - (blobuploader) - INFO - Done attempting. 06:34:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:34:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:34:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:52 INFO - (blobuploader) - INFO - Done attempting. 06:34:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:34:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:34:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:53 INFO - (blobuploader) - INFO - Done attempting. 06:34:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:34:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:54 INFO - (blobuploader) - INFO - Done attempting. 06:34:54 INFO - (blobuploader) - INFO - Iteration through files over. 06:34:54 INFO - Return code: 0 06:34:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:34:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:34:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e991a3b240cbe703be539c43df7cb1390ca8257c265a683b53fa613e78d196d6d5cbaec57235593999ff4811349f3ceb2da059db2d3c1b7a64061f218991185f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/283ba95424eb67441ec8f7b6916b9a62673d5104c5f6911156f88d10db29cae9d1c48157d62d6ac24bf6a3d1416f274eefc451a4516e6e280853986f46a244d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1de5ee3aa1888b6fe16666a4b93e4af3122bbbd1105e1cefbc2ae2dd403b755462cab123c652c661d3514f5da5be67ea7f0418797e87a5e7115f21aa2ef36109", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bfc4f7b427bcdae62ffe01e7f58d4f0c5c339b013032c373c265ade20a09baa3fa2757782edd078bf4e6a21aa285f918b0b674b6b6823af59496321bc577377"} 06:34:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:34:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:34:54 INFO - Contents: 06:34:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e991a3b240cbe703be539c43df7cb1390ca8257c265a683b53fa613e78d196d6d5cbaec57235593999ff4811349f3ceb2da059db2d3c1b7a64061f218991185f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/283ba95424eb67441ec8f7b6916b9a62673d5104c5f6911156f88d10db29cae9d1c48157d62d6ac24bf6a3d1416f274eefc451a4516e6e280853986f46a244d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1de5ee3aa1888b6fe16666a4b93e4af3122bbbd1105e1cefbc2ae2dd403b755462cab123c652c661d3514f5da5be67ea7f0418797e87a5e7115f21aa2ef36109", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bfc4f7b427bcdae62ffe01e7f58d4f0c5c339b013032c373c265ade20a09baa3fa2757782edd078bf4e6a21aa285f918b0b674b6b6823af59496321bc577377"} 06:34:54 INFO - Running post-run listener: copy_logs_to_upload_dir 06:34:54 INFO - Copying logs to upload dir... 06:34:54 INFO - mkdir: /builds/slave/test/build/upload/logs 06:34:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.192196 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-02-07 06:34:54.321252) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 06:34:54.324996) ========= 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=af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424 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/sha512/e991a3b240cbe703be539c43df7cb1390ca8257c265a683b53fa613e78d196d6d5cbaec57235593999ff4811349f3ceb2da059db2d3c1b7a64061f218991185f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/283ba95424eb67441ec8f7b6916b9a62673d5104c5f6911156f88d10db29cae9d1c48157d62d6ac24bf6a3d1416f274eefc451a4516e6e280853986f46a244d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1de5ee3aa1888b6fe16666a4b93e4af3122bbbd1105e1cefbc2ae2dd403b755462cab123c652c661d3514f5da5be67ea7f0418797e87a5e7115f21aa2ef36109", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bfc4f7b427bcdae62ffe01e7f58d4f0c5c339b013032c373c265ade20a09baa3fa2757782edd078bf4e6a21aa285f918b0b674b6b6823af59496321bc577377"} build_url:https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/cIhEByCHT-in_wXCTH24QQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e991a3b240cbe703be539c43df7cb1390ca8257c265a683b53fa613e78d196d6d5cbaec57235593999ff4811349f3ceb2da059db2d3c1b7a64061f218991185f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/283ba95424eb67441ec8f7b6916b9a62673d5104c5f6911156f88d10db29cae9d1c48157d62d6ac24bf6a3d1416f274eefc451a4516e6e280853986f46a244d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1de5ee3aa1888b6fe16666a4b93e4af3122bbbd1105e1cefbc2ae2dd403b755462cab123c652c661d3514f5da5be67ea7f0418797e87a5e7115f21aa2ef36109", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bfc4f7b427bcdae62ffe01e7f58d4f0c5c339b013032c373c265ade20a09baa3fa2757782edd078bf4e6a21aa285f918b0b674b6b6823af59496321bc577377"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 06:34:54.352604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 06:34:54.353307) ========= 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=af724c981e2a0f424dbabf99000001e7-1486476849.347888-1345619424 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 06:34:54.437364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 06:34:54.438106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 06:34:54.438805) ========= ========= Total master_lag: 0.17 =========