builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1486729819.57 results: success (0) revision: 9a08294a8eb8cea3683c6355decebce1d1876fa1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:19.572259) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:19.572791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:19.573078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:19.773988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:19.774294) ========= 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=41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-10 04:30:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2017-02-10 04:30:21 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.938092 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:20.725728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:20.726065) ========= 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=41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018992 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:20.776227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-10 04:30:20.776534) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a08294a8eb8cea3683c6355decebce1d1876fa1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a08294a8eb8cea3683c6355decebce1d1876fa1 --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=41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-10 04:30:21,197 truncating revision to first 12 chars 2017-02-10 04:30:21,197 Setting DEBUG logging. 2017-02-10 04:30:21,197 attempt 1/10 2017-02-10 04:30:21,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a08294a8eb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 04:30:23,123 unpacking tar archive at: mozilla-aurora-9a08294a8eb8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.971047 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-10 04:30:23.760240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:23.760619) ========= script_repo_revision: 9a08294a8eb8cea3683c6355decebce1d1876fa1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:23.761025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:23.761290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 04:30:23.769276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-10 04:30:23.769557) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:24 INFO - MultiFileLogger online at 20170210 04:30:24 in /builds/slave/test 04:30:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:30:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:24 INFO - {'append_to_log': False, 04:30:24 INFO - 'base_work_dir': '/builds/slave/test', 04:30:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:30:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:24 INFO - 'branch': 'Mozilla-Aurora', 04:30:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:24 INFO - 'config_files': ('talos/linux_config.py',), 04:30:24 INFO - 'default_actions': ('clobber', 04:30:24 INFO - 'read-buildbot-config', 04:30:24 INFO - 'download-and-extract', 04:30:24 INFO - 'populate-webroot', 04:30:24 INFO - 'create-virtualenv', 04:30:24 INFO - 'install', 04:30:24 INFO - 'run-tests'), 04:30:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:24 INFO - 'download_minidump_stackwalk': True, 04:30:24 INFO - 'download_symbols': 'ondemand', 04:30:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:24 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:24 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:24 INFO - 'installer_path': 'installer.exe', 04:30:24 INFO - 'log_level': 'info', 04:30:24 INFO - 'log_name': 'talos', 04:30:24 INFO - 'log_to_console': True, 04:30:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:24 INFO - 'opt_config_files': (), 04:30:24 INFO - 'pip_index': False, 04:30:24 INFO - 'sps_profile': False, 04:30:24 INFO - 'sps_profile_interval': 0, 04:30:24 INFO - 'suite': 'dromaeojs', 04:30:24 INFO - 'system_bits': '32', 04:30:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:24 INFO - 'title': 'talos-linux64-ix-026', 04:30:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:24 INFO - 'use_talos_json': True, 04:30:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:24 INFO - 'work_dir': 'build'} 04:30:24 INFO - [mozharness: 2017-02-10 12:30:24.286098Z] Running clobber step. 04:30:24 INFO - Running pre-action listener: _resource_record_pre_action 04:30:24 INFO - Running main action method: clobber 04:30:24 INFO - rmtree: /builds/slave/test/build 04:30:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:24 INFO - Running post-action listener: _resource_record_post_action 04:30:24 INFO - [mozharness: 2017-02-10 12:30:24.747733Z] Finished clobber step (success) 04:30:24 INFO - [mozharness: 2017-02-10 12:30:24.747834Z] Running read-buildbot-config step. 04:30:24 INFO - Running pre-action listener: _resource_record_pre_action 04:30:24 INFO - Running main action method: read_buildbot_config 04:30:24 INFO - Using buildbot properties: 04:30:24 INFO - { 04:30:24 INFO - "project": "", 04:30:24 INFO - "product": "firefox", 04:30:24 INFO - "who": "cbook@mozilla.com", 04:30:24 INFO - "installer_path": "public/build/target.tar.bz2", 04:30:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:30:24 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 04:30:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:30:24 INFO - "stage_platform": "linux64-pgo", 04:30:24 INFO - "basedir": "/builds/slave/test", 04:30:24 INFO - "buildnumber": 771, 04:30:24 INFO - "platform": "ubuntu64_hw", 04:30:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:30:24 INFO - "slavebuilddir": "test", 04:30:24 INFO - "taskId": "MJz4HtEJQaODu7y3-vNvMA", 04:30:24 INFO - "branch": "mozilla-aurora", 04:30:24 INFO - "script_repo_revision": "production", 04:30:24 INFO - "revision": "9a08294a8eb8cea3683c6355decebce1d1876fa1", 04:30:24 INFO - "slavename": "talos-linux64-ix-026", 04:30:24 INFO - "repo_path": "releases/mozilla-aurora" 04:30:24 INFO - } 04:30:24 INFO - Finding installer, test and symbols from parent task. 04:30:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MJz4HtEJQaODu7y3-vNvMA'}, attempt #1 04:30:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MJz4HtEJQaODu7y3-vNvMA'}, attempt #1 04:30:26 INFO - Task dependencies: BnzgM0fwSH6W0AnJsDbKoA 04:30:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA'}, attempt #1 04:30:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.tar.bz2 04:30:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/test_packages.json 04:30:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.crashreporter-symbols.zip 04:30:26 INFO - Running post-action listener: _resource_record_post_action 04:30:26 INFO - [mozharness: 2017-02-10 12:30:26.722934Z] Finished read-buildbot-config step (success) 04:30:26 INFO - [mozharness: 2017-02-10 12:30:26.723153Z] Running download-and-extract step. 04:30:26 INFO - Running pre-action listener: _resource_record_pre_action 04:30:26 INFO - Running main action method: download_and_extract 04:30:26 INFO - mkdir: /builds/slave/test/build/tests 04:30: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')]} 04:30:26 INFO - trying https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.test_packages.json 04:30:26 INFO - Downloading https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:30:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:30:27 INFO - Downloaded 896 bytes. 04:30:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:30:27 INFO - Using the following test package requirements: 04:30:27 INFO - {u'common': [u'target.common.tests.zip'], 04:30:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:30:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:30:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:30:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:30:27 INFO - u'mozbase': [u'target.common.tests.zip'], 04:30:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:30:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:30:27 INFO - u'web-platform': [u'target.common.tests.zip', 04:30:27 INFO - u'target.web-platform.tests.zip'], 04:30:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:30:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:30:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.common.tests.zip 04:30:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:30:27 INFO - Fetch https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.common.tests.zip into memory 04:30:29 INFO - Expected file size: 21857342 04:30:29 INFO - Obtained file size: 21857342 04:30:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:30:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.common.tests.zip 04:30:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:30:33 INFO - Fetch https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.common.tests.zip into memory 04:30:35 INFO - Expected file size: 21857342 04:30:35 INFO - Obtained file size: 21857342 04:30:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.talos.tests.zip 04:30:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:30:39 INFO - Fetch https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.talos.tests.zip into memory 04:30:40 INFO - Expected file size: 14403485 04:30:40 INFO - Obtained file size: 14403485 04:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:41 INFO - trying https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.tar.bz2 04:30:41 INFO - Downloading https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:30:42 INFO - Downloaded 66054863 bytes. 04:30:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.tar.bz2 04:30:42 INFO - mkdir: /builds/slave/test/properties 04:30:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:42 INFO - Contents: 04:30:42 INFO - build_url:https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.tar.bz2 04:30:42 INFO - Running post-action listener: _resource_record_post_action 04:30:42 INFO - Running post-action listener: set_extra_try_arguments 04:30:42 INFO - [mozharness: 2017-02-10 12:30:42.829215Z] Finished download-and-extract step (success) 04:30:42 INFO - [mozharness: 2017-02-10 12:30:42.829312Z] Running populate-webroot step. 04:30:42 INFO - Running pre-action listener: _resource_record_pre_action 04:30:42 INFO - Running main action method: populate_webroot 04:30:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:42 INFO - '--tppagecycles', 04:30:42 INFO - '7'], 04:30:42 INFO - 'tests': ['tsvgm']}}, 04:30:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:30:42 INFO - 'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:30:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:30:42 INFO - 'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['damp', 'tps']}, 04:30:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:30:42 INFO - 'tests': ['damp', 'tps']}, 04:30:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['dromaeo_dom']}, 04:30:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['basic_compositor_video']}, 04:30:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:30:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['a11yr', 04:30:42 INFO - 'ts_paint', 04:30:42 INFO - 'tpaint', 04:30:42 INFO - 'sessionrestore', 04:30:42 INFO - 'sessionrestore_no_auto_restore', 04:30:42 INFO - 'tabpaint']}, 04:30:42 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:42 INFO - 'ts_paint', 04:30:42 INFO - 'tpaint', 04:30:42 INFO - 'sessionrestore', 04:30:42 INFO - 'sessionrestore_no_auto_restore', 04:30:42 INFO - 'tabpaint']}, 04:30:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:42 INFO - 'ts_paint', 04:30:42 INFO - 'tpaint', 04:30:42 INFO - 'sessionrestore', 04:30:42 INFO - 'sessionrestore_no_auto_restore', 04:30:42 INFO - 'tabpaint']}, 04:30:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:42 INFO - 'ts_paint', 04:30:42 INFO - 'tpaint', 04:30:42 INFO - 'sessionrestore', 04:30:42 INFO - 'sessionrestore_no_auto_restore', 04:30:42 INFO - 'tabpaint']}, 04:30:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['a11yr', 04:30:42 INFO - 'ts_paint', 04:30:42 INFO - 'tpaint', 04:30:42 INFO - 'sessionrestore', 04:30:42 INFO - 'sessionrestore_no_auto_restore', 04:30:42 INFO - 'tabpaint']}, 04:30:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['a11yr', 04:30:42 INFO - 'ts_paint', 04:30:42 INFO - 'tpaint', 04:30:42 INFO - 'sessionrestore', 04:30:42 INFO - 'sessionrestore_no_auto_restore', 04:30:42 INFO - 'tabpaint']}, 04:30:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['tsvgx', 04:30:42 INFO - 'tsvgr_opacity', 04:30:42 INFO - 'tart', 04:30:42 INFO - 'tscrollx', 04:30:42 INFO - 'cart', 04:30:42 INFO - 'tsvg_static']}, 04:30:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:42 INFO - 'tsvgr_opacity', 04:30:42 INFO - 'tart', 04:30:42 INFO - 'tscrollx', 04:30:42 INFO - 'cart', 04:30:42 INFO - 'tsvg_static']}, 04:30:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:30:42 INFO - 'talos_options': ['--disable-e10s'], 04:30:42 INFO - 'tests': ['tp5o']}, 04:30:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:30:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:30:42 INFO - 'talos_options': ['--disable-e10s', 04:30:42 INFO - '--xperf_path', 04:30:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:42 INFO - 'tests': ['tp5n']}, 04:30:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:30:42 INFO - 'talos_options': ['--xperf_path', 04:30:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:42 INFO - 'tests': ['tp5n']}}, 04:30:42 INFO - 'talos.zip': {'path': '', 04:30:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:42 INFO - Running post-action listener: _resource_record_post_action 04:30:42 INFO - [mozharness: 2017-02-10 12:30:42.842400Z] Finished populate-webroot step (success) 04:30:42 INFO - [mozharness: 2017-02-10 12:30:42.842489Z] Running create-virtualenv step. 04:30:42 INFO - Running pre-action listener: _resource_record_pre_action 04:30:42 INFO - Running main action method: create_virtualenv 04:30:42 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:30:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:42 INFO - Using real prefix '/usr' 04:30:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:45 INFO - Installing pip.................done. 04:30:45 INFO - Return code: 0 04:30:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:45 INFO - Reading from file tmpfile_stdout 04:30:45 INFO - Output received: 04:30:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:30:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 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 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:30:46 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 04:30:46 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 04:30:46 INFO - Using env: {'DISPLAY': ':0', 04:30:46 INFO - 'HOME': '/home/cltbld', 04:30:46 INFO - 'LANG': 'en_US.UTF-8', 04:30:46 INFO - 'LANGUAGE': 'en_US:en', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MAIL': '/var/mail/cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SHLVL': '1', 04:30:46 INFO - 'TERM': 'linux', 04:30:46 INFO - 'TMOUT': '86400', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - '_': '/tools/buildbot/bin/python'} 04:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:46 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 04:30:46 INFO - Cleaning up... 04:30:46 INFO - Return code: 0 04:30:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:47 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 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:30:47 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 04:30:47 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 04:30:47 INFO - Using env: {'DISPLAY': ':0', 04:30:47 INFO - 'HOME': '/home/cltbld', 04:30:47 INFO - 'LANG': 'en_US.UTF-8', 04:30:47 INFO - 'LANGUAGE': 'en_US:en', 04:30:47 INFO - 'LOGNAME': 'cltbld', 04:30:47 INFO - 'MAIL': '/var/mail/cltbld', 04:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:47 INFO - 'MOZ_NO_REMOTE': '1', 04:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:47 INFO - 'NO_EM_RESTART': '1', 04:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:47 INFO - 'PWD': '/builds/slave/test', 04:30:47 INFO - 'SHELL': '/bin/bash', 04:30:47 INFO - 'SHLVL': '1', 04:30:47 INFO - 'TERM': 'linux', 04:30:47 INFO - 'TMOUT': '86400', 04:30:47 INFO - 'USER': 'cltbld', 04:30:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:47 INFO - '_': '/tools/buildbot/bin/python'} 04:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:48 INFO - Downloading/unpacking psutil>=3.1.1 04:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:52 INFO - Installing collected packages: psutil 04:30:52 INFO - Running setup.py install for psutil 04:30:52 INFO - building 'psutil._psutil_linux' extension 04:30:52 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 04:30:52 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 04:30:53 INFO - building 'psutil._psutil_posix' extension 04:30:53 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 04:30:53 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 04:30:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:53 INFO - Successfully installed psutil 04:30:53 INFO - Cleaning up... 04:30:53 INFO - Return code: 0 04:30:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:30:54 INFO - Using env: {'DISPLAY': ':0', 04:30:54 INFO - 'HOME': '/home/cltbld', 04:30:54 INFO - 'LANG': 'en_US.UTF-8', 04:30:54 INFO - 'LANGUAGE': 'en_US:en', 04:30:54 INFO - 'LOGNAME': 'cltbld', 04:30:54 INFO - 'MAIL': '/var/mail/cltbld', 04:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:54 INFO - 'MOZ_NO_REMOTE': '1', 04:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:54 INFO - 'NO_EM_RESTART': '1', 04:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:54 INFO - 'PWD': '/builds/slave/test', 04:30:54 INFO - 'SHELL': '/bin/bash', 04:30:54 INFO - 'SHLVL': '1', 04:30:54 INFO - 'TERM': 'linux', 04:30:54 INFO - 'TMOUT': '86400', 04:30:54 INFO - 'USER': 'cltbld', 04:30:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:54 INFO - '_': '/tools/buildbot/bin/python'} 04:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:58 INFO - Installing collected packages: mozsystemmonitor 04:30:58 INFO - Running setup.py install for mozsystemmonitor 04:30:58 INFO - Successfully installed mozsystemmonitor 04:30:58 INFO - Cleaning up... 04:30:58 INFO - Return code: 0 04:30:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30:58 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')]} 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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')]} 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:59 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 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:30:59 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 04:30:59 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 04:30:59 INFO - Using env: {'DISPLAY': ':0', 04:30:59 INFO - 'HOME': '/home/cltbld', 04:30:59 INFO - 'LANG': 'en_US.UTF-8', 04:30:59 INFO - 'LANGUAGE': 'en_US:en', 04:30:59 INFO - 'LOGNAME': 'cltbld', 04:30:59 INFO - 'MAIL': '/var/mail/cltbld', 04:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:59 INFO - 'MOZ_NO_REMOTE': '1', 04:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:59 INFO - 'NO_EM_RESTART': '1', 04:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:59 INFO - 'PWD': '/builds/slave/test', 04:30:59 INFO - 'SHELL': '/bin/bash', 04:30:59 INFO - 'SHLVL': '1', 04:30:59 INFO - 'TERM': 'linux', 04:30:59 INFO - 'TMOUT': '86400', 04:30:59 INFO - 'USER': 'cltbld', 04:30:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:59 INFO - '_': '/tools/buildbot/bin/python'} 04:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:31:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:04 INFO - warning: no files found matching '*.txt' 04:31:04 INFO - no previously-included directories found matching 'build' 04:31:04 INFO - no previously-included directories found matching 'dist' 04:31:04 INFO - no previously-included directories found matching '.git*' 04:31:04 INFO - Installing collected packages: jsonschema, functools32 04:31:04 INFO - Running setup.py install for functools32 04:31:04 INFO - warning: no files found matching '*.txt' 04:31:04 INFO - no previously-included directories found matching 'build' 04:31:04 INFO - no previously-included directories found matching 'dist' 04:31:04 INFO - no previously-included directories found matching '.git*' 04:31:04 INFO - Successfully installed jsonschema functools32 04:31:04 INFO - Cleaning up... 04:31:05 INFO - Return code: 0 04:31:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:31:06 INFO - Using env: {'DISPLAY': ':0', 04:31:06 INFO - 'HOME': '/home/cltbld', 04:31:06 INFO - 'LANG': 'en_US.UTF-8', 04:31:06 INFO - 'LANGUAGE': 'en_US:en', 04:31:06 INFO - 'LOGNAME': 'cltbld', 04:31:06 INFO - 'MAIL': '/var/mail/cltbld', 04:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:06 INFO - 'MOZ_NO_REMOTE': '1', 04:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:06 INFO - 'NO_EM_RESTART': '1', 04:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:06 INFO - 'PWD': '/builds/slave/test', 04:31:06 INFO - 'SHELL': '/bin/bash', 04:31:06 INFO - 'SHLVL': '1', 04:31:06 INFO - 'TERM': 'linux', 04:31:06 INFO - 'TMOUT': '86400', 04:31:06 INFO - 'USER': 'cltbld', 04:31:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:06 INFO - '_': '/tools/buildbot/bin/python'} 04:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:31:06 INFO - Cleaning up... 04:31:06 INFO - Return code: 0 04:31:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:07 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 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:31:07 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 04:31:07 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 04:31:07 INFO - Using env: {'DISPLAY': ':0', 04:31:07 INFO - 'HOME': '/home/cltbld', 04:31:07 INFO - 'LANG': 'en_US.UTF-8', 04:31:07 INFO - 'LANGUAGE': 'en_US:en', 04:31:07 INFO - 'LOGNAME': 'cltbld', 04:31:07 INFO - 'MAIL': '/var/mail/cltbld', 04:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:07 INFO - 'MOZ_NO_REMOTE': '1', 04:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:07 INFO - 'NO_EM_RESTART': '1', 04:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:07 INFO - 'PWD': '/builds/slave/test', 04:31:07 INFO - 'SHELL': '/bin/bash', 04:31:07 INFO - 'SHLVL': '1', 04:31:07 INFO - 'TERM': 'linux', 04:31:07 INFO - 'TMOUT': '86400', 04:31:07 INFO - 'USER': 'cltbld', 04:31:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:07 INFO - '_': '/tools/buildbot/bin/python'} 04:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:11 INFO - Downloading docopt-0.6.1.tar.gz 04:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:11 INFO - Running setup.py install for blobuploader 04:31:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:11 INFO - Running setup.py install for requests 04:31:11 INFO - Running setup.py install for docopt 04:31:12 INFO - Successfully installed blobuploader requests docopt 04:31:12 INFO - Cleaning up... 04:31:12 INFO - Return code: 0 04:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:12 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')]} 04:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:12 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')]} 04:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:13 INFO - Using env: {'DISPLAY': ':0', 04:31:13 INFO - 'HOME': '/home/cltbld', 04:31:13 INFO - 'LANG': 'en_US.UTF-8', 04:31:13 INFO - 'LANGUAGE': 'en_US:en', 04:31:13 INFO - 'LOGNAME': 'cltbld', 04:31:13 INFO - 'MAIL': '/var/mail/cltbld', 04:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:13 INFO - 'MOZ_NO_REMOTE': '1', 04:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:13 INFO - 'NO_EM_RESTART': '1', 04:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:13 INFO - 'PWD': '/builds/slave/test', 04:31:13 INFO - 'SHELL': '/bin/bash', 04:31:13 INFO - 'SHLVL': '1', 04:31:13 INFO - 'TERM': 'linux', 04:31:13 INFO - 'TMOUT': '86400', 04:31:13 INFO - 'USER': 'cltbld', 04:31:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:13 INFO - '_': '/tools/buildbot/bin/python'} 04:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:14 INFO - Running setup.py (path:/tmp/pip-Mjiqmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:14 INFO - Running setup.py (path:/tmp/pip-PORIeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:14 INFO - Running setup.py (path:/tmp/pip-HRdFLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:14 INFO - Running setup.py (path:/tmp/pip-ILL9dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:14 INFO - Running setup.py (path:/tmp/pip-DWh16C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:14 INFO - Running setup.py (path:/tmp/pip-xTkjK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:14 INFO - Running setup.py (path:/tmp/pip-vUzzhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:14 INFO - Running setup.py (path:/tmp/pip-FuUXL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:14 INFO - Running setup.py (path:/tmp/pip-61pmv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:14 INFO - Running setup.py (path:/tmp/pip-EBwldJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:14 INFO - Running setup.py (path:/tmp/pip-tZ5i72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:14 INFO - Running setup.py (path:/tmp/pip-FC0xTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:14 INFO - Running setup.py (path:/tmp/pip-JAHH9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:15 INFO - Running setup.py (path:/tmp/pip-3gWLIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:15 INFO - Running setup.py (path:/tmp/pip-ouTVse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:15 INFO - Running setup.py (path:/tmp/pip-jGqGql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:15 INFO - Running setup.py (path:/tmp/pip-go9a3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:15 INFO - Running setup.py install for manifestparser 04:31:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for mozcrash 04:31:15 INFO - Running setup.py install for mozdebug 04:31:15 INFO - Running setup.py install for mozdevice 04:31:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for mozfile 04:31:15 INFO - Running setup.py install for mozhttpd 04:31:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for mozinfo 04:31:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Running setup.py install for mozInstall 04:31:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Running setup.py install for mozleak 04:31:16 INFO - Running setup.py install for mozlog 04:31:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Running setup.py install for moznetwork 04:31:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Running setup.py install for mozprocess 04:31:16 INFO - Running setup.py install for mozprofile 04:31:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Running setup.py install for mozrunner 04:31:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Running setup.py install for mozscreenshot 04:31:16 INFO - Running setup.py install for moztest 04:31:17 INFO - Running setup.py install for mozversion 04:31:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:17 INFO - Cleaning up... 04:31:17 INFO - Return code: 0 04:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:18 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 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:31:18 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 04:31:18 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 04:31:18 INFO - Using env: {'DISPLAY': ':0', 04:31:18 INFO - 'HOME': '/home/cltbld', 04:31:18 INFO - 'LANG': 'en_US.UTF-8', 04:31:18 INFO - 'LANGUAGE': 'en_US:en', 04:31:18 INFO - 'LOGNAME': 'cltbld', 04:31:18 INFO - 'MAIL': '/var/mail/cltbld', 04:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:18 INFO - 'MOZ_NO_REMOTE': '1', 04:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:18 INFO - 'NO_EM_RESTART': '1', 04:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:18 INFO - 'PWD': '/builds/slave/test', 04:31:18 INFO - 'SHELL': '/bin/bash', 04:31:18 INFO - 'SHLVL': '1', 04:31:18 INFO - 'TERM': 'linux', 04:31:18 INFO - 'TMOUT': '86400', 04:31:18 INFO - 'USER': 'cltbld', 04:31:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:18 INFO - '_': '/tools/buildbot/bin/python'} 04:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:18 INFO - Running setup.py (path:/tmp/pip-LDnnSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:18 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)) 04:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:18 INFO - Running setup.py (path:/tmp/pip-vu9Xm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:18 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)) 04:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:18 INFO - Running setup.py (path:/tmp/pip-bejcPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:19 INFO - Running setup.py (path:/tmp/pip-teCSVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:19 INFO - Running setup.py (path:/tmp/pip-lMzCpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:19 INFO - Running setup.py (path:/tmp/pip-O9iI5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:19 INFO - Running setup.py (path:/tmp/pip-1CgOkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:19 INFO - Running setup.py (path:/tmp/pip-2kfQVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:19 INFO - Running setup.py (path:/tmp/pip-9N748x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:19 INFO - Running setup.py (path:/tmp/pip-TVqHC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:19 INFO - Running setup.py (path:/tmp/pip-VFvvL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:19 INFO - Running setup.py (path:/tmp/pip-EZG6rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:19 INFO - Running setup.py (path:/tmp/pip-X4TQWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:19 INFO - Running setup.py (path:/tmp/pip-sznxWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:19 INFO - Running setup.py (path:/tmp/pip-S8Nd2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:19 INFO - Running setup.py (path:/tmp/pip-lh0zZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:19 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)) 04:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:19 INFO - Running setup.py (path:/tmp/pip-g48qgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:20 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)) 04:31:20 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)) 04:31:20 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)) 04:31:20 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)) 04:31:20 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)) 04:31:20 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)) 04:31:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:20 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 04:31:20 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 04:31:20 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 04:31:20 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 04:31:20 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 04:31:20 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 04:31:24 INFO - Downloading blessings-1.6.tar.gz 04:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:24 INFO - Installing collected packages: blessings 04:31:24 INFO - Running setup.py install for blessings 04:31:24 INFO - Successfully installed blessings 04:31:24 INFO - Cleaning up... 04:31:24 INFO - Return code: 0 04:31:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:24 INFO - Reading from file tmpfile_stdout 04:31:24 INFO - Current package versions: 04:31:24 INFO - argparse == 1.2.1 04:31:24 INFO - blessings == 1.6 04:31:24 INFO - blobuploader == 1.2.4 04:31:24 INFO - docopt == 0.6.1 04:31:24 INFO - functools32 == 3.2.3-2 04:31:24 INFO - jsonschema == 2.5.1 04:31:24 INFO - manifestparser == 1.1 04:31:24 INFO - mozInstall == 1.12 04:31:24 INFO - mozcrash == 1.0 04:31:24 INFO - mozdebug == 0.1 04:31:24 INFO - mozdevice == 0.49 04:31:24 INFO - mozfile == 1.2 04:31:24 INFO - mozhttpd == 0.7 04:31:24 INFO - mozinfo == 0.9 04:31:24 INFO - mozleak == 0.1 04:31:24 INFO - mozlog == 3.4 04:31:24 INFO - moznetwork == 0.27 04:31:24 INFO - mozprocess == 0.24 04:31:24 INFO - mozprofile == 0.28 04:31:24 INFO - mozrunner == 6.13 04:31:24 INFO - mozscreenshot == 0.1 04:31:24 INFO - mozsystemmonitor == 0.3 04:31:24 INFO - moztest == 0.8 04:31:24 INFO - mozversion == 1.4 04:31:24 INFO - psutil == 3.1.1 04:31:24 INFO - requests == 1.2.3 04:31:24 INFO - wsgiref == 0.1.2 04:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:24 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')]} 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:24 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')]} 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:26 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 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:31:26 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 04:31:26 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 04:31:26 INFO - Using env: {'DISPLAY': ':0', 04:31:26 INFO - 'HOME': '/home/cltbld', 04:31:26 INFO - 'LANG': 'en_US.UTF-8', 04:31:26 INFO - 'LANGUAGE': 'en_US:en', 04:31:26 INFO - 'LOGNAME': 'cltbld', 04:31:26 INFO - 'MAIL': '/var/mail/cltbld', 04:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:26 INFO - 'MOZ_NO_REMOTE': '1', 04:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:26 INFO - 'NO_EM_RESTART': '1', 04:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:26 INFO - 'PWD': '/builds/slave/test', 04:31:26 INFO - 'SHELL': '/bin/bash', 04:31:26 INFO - 'SHLVL': '1', 04:31:26 INFO - 'TERM': 'linux', 04:31:26 INFO - 'TMOUT': '86400', 04:31:26 INFO - 'USER': 'cltbld', 04:31:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:26 INFO - '_': '/tools/buildbot/bin/python'} 04:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 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)) 04:31:26 INFO - Cleaning up... 04:31:26 INFO - Return code: 0 04:31:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, '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': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', '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 04:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:28 INFO - Using env: {'DISPLAY': ':0', 04:31:28 INFO - 'HOME': '/home/cltbld', 04:31:28 INFO - 'LANG': 'en_US.UTF-8', 04:31:28 INFO - 'LANGUAGE': 'en_US:en', 04:31:28 INFO - 'LOGNAME': 'cltbld', 04:31:28 INFO - 'MAIL': '/var/mail/cltbld', 04:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:28 INFO - 'MOZ_NO_REMOTE': '1', 04:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:28 INFO - 'NO_EM_RESTART': '1', 04:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:28 INFO - 'PWD': '/builds/slave/test', 04:31:28 INFO - 'SHELL': '/bin/bash', 04:31:28 INFO - 'SHLVL': '1', 04:31:28 INFO - 'TERM': 'linux', 04:31:28 INFO - 'TMOUT': '86400', 04:31:28 INFO - 'USER': 'cltbld', 04:31:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:28 INFO - '_': '/tools/buildbot/bin/python'} 04:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:28 INFO - Cleaning up... 04:31:28 INFO - Return code: 0 04:31:28 INFO - Running post-action listener: _resource_record_post_action 04:31:28 INFO - Running post-action listener: _start_resource_monitoring 04:31:28 INFO - Starting resource monitoring. 04:31:28 INFO - [mozharness: 2017-02-10 12:31:28.334705Z] Finished create-virtualenv step (success) 04:31:28 INFO - [mozharness: 2017-02-10 12:31:28.335161Z] Running install step. 04:31:28 INFO - Running pre-action listener: _resource_record_pre_action 04:31:28 INFO - Running main action method: install 04:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:28 INFO - Reading from file tmpfile_stdout 04:31:28 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:28 INFO - Reading from file tmpfile_stdout 04:31:28 INFO - Output received: 04:31:28 INFO - Usage: mozinstall [options] installer 04:31:28 INFO - Options: 04:31:28 INFO - -h, --help show this help message and exit 04:31:28 INFO - -d DEST, --destination=DEST 04:31:28 INFO - Directory to install application into. [default: 04:31:28 INFO - "/builds/slave/test"] 04:31:28 INFO - --app=APP Application being installed. [default: firefox] 04:31:28 INFO - mkdir: /builds/slave/test/build/application 04:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:31:45 INFO - Reading from file tmpfile_stdout 04:31:45 INFO - Output received: 04:31:45 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:45 INFO - Running post-action listener: _resource_record_post_action 04:31:45 INFO - [mozharness: 2017-02-10 12:31:45.152676Z] Finished install step (success) 04:31:45 INFO - [mozharness: 2017-02-10 12:31:45.152954Z] Running run-tests step. 04:31:45 INFO - Running pre-action listener: _resource_record_pre_action 04:31:45 INFO - Running main action method: run_tests 04:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:45 INFO - Python 2.7.3 04:31:45 INFO - Return code: 0 04:31:45 INFO - grabbing minidump binary from tooltool 04:31: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')]} 04:31:45 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 0x1a95850>, '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 0x1a0a6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ab60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:45 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 04:31:45 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 04:31:45 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 04:31:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:45 INFO - Return code: 0 04:31:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 04:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 04:31:45 INFO - Using env: {'DISPLAY': ':0', 04:31:45 INFO - 'HOME': '/home/cltbld', 04:31:45 INFO - 'LANG': 'en_US.UTF-8', 04:31:45 INFO - 'LANGUAGE': 'en_US:en', 04:31:45 INFO - 'LOGNAME': 'cltbld', 04:31:45 INFO - 'MAIL': '/var/mail/cltbld', 04:31:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:45 INFO - 'MOZ_NO_REMOTE': '1', 04:31:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:45 INFO - 'NO_EM_RESTART': '1', 04:31:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:45 INFO - 'PWD': '/builds/slave/test', 04:31:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:45 INFO - 'SHELL': '/bin/bash', 04:31:45 INFO - 'SHLVL': '1', 04:31:45 INFO - 'TERM': 'linux', 04:31:45 INFO - 'TMOUT': '86400', 04:31:45 INFO - 'USER': 'cltbld', 04:31:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314', 04:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:45 INFO - '_': '/tools/buildbot/bin/python'} 04:31:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 04:31:45 INFO - mozversion application_buildid: 20170210113645 04:31:45 INFO - mozversion application_changeset: 9a08294a8eb8cea3683c6355decebce1d1876fa1 04:31:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:31:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:45 INFO - mozversion application_name: Firefox 04:31:45 INFO - mozversion application_remotingname: firefox-dev 04:31:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:31:45 INFO - mozversion application_vendor: Mozilla 04:31:45 INFO - mozversion application_version: 53.0a2 04:31:45 INFO - mozversion platform_buildid: 20170210113645 04:31:45 INFO - mozversion platform_changeset: 9a08294a8eb8cea3683c6355decebce1d1876fa1 04:31:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:31:45 INFO - mozversion platform_version: 53.0a2 04:31:45 INFO - using testdate: 1486729905 04:31:45 INFO - actual date: 1486729905 04:31:45 INFO - starting webserver on 'localhost:32964' 04:31:45 INFO - SUITE-START | Running 2 tests 04:31:45 INFO - TEST-START | dromaeo_css 04:31:45 INFO - operating with platform_type : linux_ 04:31:45 INFO - Initialising browser for dromaeo_css test... 04:31:45 INFO - TEST-INFO | started process 1622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavlizW/profile http://localhost:32964/getInfo.html) 04:31:49 INFO - PROCESS | 1622 | __metrics Screen width/height:1600/1200 04:31:49 INFO - PROCESS | 1622 | colorDepth:24 04:31:49 INFO - PROCESS | 1622 | Browser inner width/height: 1024/697 04:31:49 INFO - PROCESS | 1622 | __metrics 04:31:50 INFO - PROCESS | 1622 | 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" 04:31:50 INFO - PROCESS | 1622 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:51 INFO - TEST-INFO | 1622: exit 0 04:31:51 INFO - Browser initialized. 04:31:51 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:51 INFO - TEST-INFO | started process 1716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavlizW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:02 INFO - PROCESS | 1716 | RSS: Main: 138801152 04:32:02 INFO - PROCESS | 1716 | 04:35:03 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:32964/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32964/tests/dromaeo/cssquery-ext.html) 04:35:04 INFO - PROCESS | 1716 | RSS: Main: 241418240 04:35:04 INFO - PROCESS | 1716 | 04:36:53 INFO - PROCESS | 1716 | ************************* 04:36:53 INFO - PROCESS | 1716 | A coding exception was thrown and uncaught in a Task. 04:36:53 INFO - PROCESS | 1716 | 04:36:53 ERROR - PROCESS | 1716 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:53 INFO - PROCESS | 1716 | Full stack: 04:36:53 INFO - PROCESS | 1716 | ************************* 04:38:07 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:32964/tests/dromaeo/cssquery-ext.html (next: http://localhost:32964/tests/dromaeo/cssquery-jquery.html) 04:38:07 INFO - PROCESS | 1716 | RSS: Main: 230162432 04:38:07 INFO - PROCESS | 1716 | 04:41:09 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:32964/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32964/tests/dromaeo/cssquery-mootools.html) 04:41:10 INFO - PROCESS | 1716 | RSS: Main: 171618304 04:41:10 INFO - PROCESS | 1716 | 04:44:11 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:32964/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32964/tests/dromaeo/cssquery-prototype.html) 04:44:12 INFO - PROCESS | 1716 | RSS: Main: 219705344 04:44:12 INFO - PROCESS | 1716 | 04:47:15 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:32964/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32964/tests/dromaeo/cssquery-yui.html) 04:47:15 INFO - PROCESS | 1716 | RSS: Main: 175259648 04:47:15 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | Cycle 1(1): loaded http://localhost:32964/tests/dromaeo/cssquery-yui.html (next: http://localhost:32964/tests/dromaeo/cssquery-dojo.html) 04:50:18 INFO - PROCESS | 1716 | RSS: Main: 263880704 04:50:18 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | __start_tp_report 04:50:18 INFO - PROCESS | 1716 | _x_x_mozilla_page_load 04:50:18 INFO - PROCESS | 1716 | _x_x_mozilla_page_load_details 04:50:18 INFO - PROCESS | 1716 | |i|pagename|runs| 04:50:18 INFO - PROCESS | 1716 | |0;dojo.html;3296.4066468035753;3305.752068594856;3335.483000134979;3363.89908302751;3373.595168579771;5366;5445.945540544599;5470.781168753255;5471;5477.726113694314;5457.863553411166;5460.754266058027;5473.589480788937;5473.698946557938;5478.342598888129;4877.244027175793;4896.77964491597;4931.852044438655;4953.950460495403;4969.900601987958;4877.244027175793;4917.45907950127;4968.40379154502;4979.975100124512;5009.248612708105;4840.87897802556;4887.193613053842;4893.559579637832;4924.70451772893;5015.3730783652045;4992.350994370745;5026.924596131079;5029.773660185264;5029.849104526834;5046.899062018739;4938.703677779345;4950.331705219785;4979.2282196259275;4995.825146119904;5002.324686167357;5210.114280572312;5293.153095504739;5362.6782393056155;5444.346678398578;5448.346198456171;5926.288845338544;5927.2590926134235;5927.644341339534;5927.851803704899;5952.375000624916;5905.8818823623715;5955.464008239279;5962.731677074542;5963.314218864843;5971.253593300838;5340.599455040888;5382.4886635769535;5450.127979523258;5493.148561972901;5548.361938377098;6035.698215089228;6042.12389203563;6045.6070355426755;6069;6071.605345652519;5763.4812866842185;5808.79669211584;5817.7091145442555;5822.82531524055;5830.271216097988;5685.431456854364;5708.086706127083;5716.056850619684;5831.125331200269;5834.766609335579;5771;5797;5863.589548731633;5890.352061273256;5893.351731309553;5864.325602555676;5869.442402971711;5873.236479257669;5873.295204575393;5879.088741245114;4330.740155590612;4345.326474396474;4452.510223875371;4460.375547423363;4479.70881892676;3977.8607748729232;4015.2371049500503;4028.3756017817286;4051.5948405159247;4092.6725861930972;5685.943140568541;5689.2603961485565;5695.117256825199;5698.430156984351;5728.742206600713;5719.999000174953;5832.533397328203;5856.121581762684;5936.1986131871645;5951.672658003851;5676.375598684142;5747.712614369265;5761;5780.046292361797;5786.710664466844;5032.169692000779;5048.697078175248;5097.133487307166;5104.259882317117;5127.461616530285;6066.48434883031;6120.387961204022;6236.220472440945;6260.248770147611;6291;5859.44335288147;5866.911996319973;5871.6770577616935;5956.255468066492;5992.580519363602;6234.657093859882;6260.7495700171485;6282.403171698681;6294.181756371642;6297.118403423616;5590.385057643737;5824.330202026821;5882.911756323744;5894.764209431574;5927.110933360031;5695;5798.76804927815;5799;5803.419658034163;5927.4665280125;5691.8292451226525;5743.483086522233;5746.712664366682;5750.741216645178;5755.798547050833;5738.282714660668;5738.483536481736;5743.540516758566;5745.052066408995;5746.195532625519;5596.776128954796;5640.746166422438;5642.7460764266525;5657.688827114548;5672.801451949162;5791.507721843691;5805.274340707411;5811.157382179645;5812.128180772918;5812.912806307824;5676.602637815313;5688.40271771458;5690.573207009408;5695.487406133468;5696.601237913306 04:50:18 INFO - PROCESS | 1716 | |1;ext.html;600.2586805295459;601.5007543738694;619.9814005579834;631.5295105146666;656.3075954867613;37846;48192.277115843244;49562.75218623911;49576;49600.007999840025;51203.74398128013;51629.48370516294;51659.74170129153;51733.22400164;51735.482645173535;8690.174433428814;9357.438553686783;9554.522273886312;9597.136257736802;9598.376105553152;8807.07525709801;11178.720531986684;11414.543418263302;11439.370834604093;11748.236364636314;11378.658640240807;11441.713957151054;11453;11556.191066625339;11583.768324633502;11441.885581144206;11493.252938558968;11493.367864767435;11504.654860354203;11509.194356395055;11257.605983790529;11335.886641133566;11338;11340.319580825177;11341.432928353632;47976.28035579469;48099.03801923942;48225;48280.758596207146;48354.27468587974;4320.848770293024;4497.9325310120375;4514.0971805639;4519.661025423106;4717.669763116583;32225.51661725076;32274.515882261785;32406.513902291485;32705.345893082005;33503;4673.345731597579;4713.505081966378;4728;4775.403074615673;4811.615070794328;322289;324788.3760581206;326544;327122;327343.0898536524;60941.39058609446;61466.69266653638;61841;61998.380016200164;62055.379446205865;65165.348346516876;65296.67351663306;65316;65344.673276633315;65359.346406535326;17855;18302.450926472226;18311.63376732458;18340;18373.63252734938;13015.349232538525;13256.602301930765;13782.448702051806;14076.155430674193;14503.927480362741;19298.22807087729;19915;20389.388318350473;20394.388168354973;20415.183392664127;7025.367716905503;7133.607651579213;7177.354038136593;7251.963740181371;7269.382102521239;983.1004630762915;994.2592768387598;1002.4035698759227;1004.9949750251202;1005.5726316315537;33929.994421866344;33981.15047123842;34179.487307690404;34219;34421.82789086038;1100.779844031197;1164.3194358678236;1184.7452797648548;1185.934773587461;1208.486393282869;18458;18470;18522.81477185211;18547.629047418977;18556.257749689863;163527;163701.18149409175;164009;164146;164396;70508.29491705017;71180.28819711736;71219;71332.64333678299;71440.28559714336;1551.8603325700515;1552.0765144738862;1554.8678362339328;1585.2866210205223;1599.928003239857;33025.50461743124;34413.827930860185;34676.82661586676;34709.305813883075;34789.65210347864;60626.09060864179;61348;61376.38623613707;61587.38412615816;61613.383866160766;384287;384317;384340;384641;384852;25633.97464101415;25832.095876644227;30930.381392371575;32991;33345.333093338486;52081.47918520766;52335.214971774694;52796.47203528069;53195.46804531905;53421;44901.77549112234;45829.31256031229;46078;46442;47241;44090.338644920994;44302.556974431136;45291.320630191236;45983.54016459793;46283;43883.78058109689;43982.78008610065;44235.55764442314;44437.55562444334;48096.7595162022;43447.78276108599;44562;47413.52586474229;47751.179905608165;49451;32752.181195470304;34696.306073878884;34711.47932781061;34978.95063148109;35285.47071793874 04:50:18 INFO - PROCESS | 1716 | |2;jquery.html;383.0232906089471;445.5366418924319;447.25085481817956;448.92817149256115;453.7209616086108;20062.59874802503;20511.692324615142;22002;22072.11711531541;22450.214242501515;21916.671249931263;22100.88949555254;22152.778472215272;22215.888920555415;22495.437614059658;6094.299155597097;6118.418750218733;6202.317745048041;6278.780242691507;6320.683965801714;6129.662868542228;6225.3463386344465;6231.5326350523665;6233.71948262327;6237.875242495147;6049.395060493959;6191.473724733403;6197.008478643418;6272.905906411407;6318.8104356869135;6291.591046582003;6417.26201486828;6448.903266451007;6451.645159516224;6454.644994525299;6346.777862774781;6381.93618063818;6396.1045453636525;6405.103285540028;6410.519211059142;26089.73910260892;26478.338041548923;26687.19938401851;26891.32771680704;26913.730862691318;2823.8446885421295;2880.323124065843;2881.2940829496697;2887.422515496888;2887.4802535543595;10918.235723499358;11246.831297530543;11438.485268162869;11440.370779607118;11552.422378881107;2066.844986625994;2071.4407110080347;2118.9152433902777;2224.9443763906033;2226.76618955009;88203;94053.52973235158;95871;96836;103060;11407.828882566768;12302.692432689255;12401.813972790414;12784.360781960864;12829.294388808705;16606.916965415337;17093.572660683334;17862.28550857977;17868.28526858937;18710.906445467685;9035.232005279493;9174.174324310845;9285.814283714422;9437.103475169848;9468.715938521855;8843.823123537493;8917;8920.687775927941;9073.863892041625;9083.954580227057;5460.208269800856;5467.125259958467;5523.143912693539;5550.55595552363;5595.804146854841;2120.6182887080167;2129.6592545192693;2184.8798316092766;2193.1994821889894;2203.471166919928;919.2508105893676;941.7316064921602;943.6084025129494;954.6038394066385;958.9568469418892;19519;21253.21684112389;21487.140514379564;21491.570168596852;21548.35354939354;945.772705279058;951.7906060666643;957.7461972577272;961.4663861556903;961.9086186812242;11514.30914145154;11765.352905590275;11909.22590031645;11967.042636589053;12044.156909016285;452355;461262;461701;665242;737635;89343;89674;93828;103227.48386258021;118906.4054679721;1135.778523187987;1149.0520320735427;1188.6790566547156;1191.5769901684778;1192.9164958452825;19367.3221437249;19372.903135484234;19396.709049363988;19693.704594431383;19740.210391584176;46142;46419.76790116028;47850;47931.281030783866;48146;65828;66024;66248.66875665591;66426.66786666035;66819.99310030963;9509.952450237704;9629.470379129216;9630.711078667651;9673.564689588844;9755.658551950648;13100.082994190696;13671.111377760413;13716.862831371558;13897.930510347383;13901.58295251144;11734.823977640172;11835.763284734085;11975.580854670045;12039;12040.518379264731;12319.692007699521;12339.07456940715;12343.753124937271;12457.626271211879;12580.370981451073;12316.50733970667;12389.75220495567;12400.255984640951;12411.255324680187;12466.812997805222;9056.773580660536;9180;9208.12522810332;9444.905550944677;9588.137067663944;9429.62281508732;12340.259584424963;12563.685907852378;12645.557405490763;12658.493660253487 04:50:18 INFO - PROCESS | 1716 | |3;mootools.html;1471.6320919770058;1487.970240595189;1489.069331667708;1506.8493150684933;1512.6974605078985;8152.59237038148;8613.655453781857;8618.913810861904;8643;8697.391182617219;7574.734884279052;7790.805229869256;8163.836723265546;8400.83198336033;8458.746237612866;2365.373176108328;2384.9284521464383;2386.296042667417;2394.1022116706235;2401.327628264089;2353.705786776653;2365.7515960824126;2392.234484964812;2392.5334559760854;2395.1138078910826;2316.756740542244;2322.593546129429;2344.9413764655933;2346.3195673254822;2347.9178228762;2263.7509873913855;2308.2959697292317;2317.2584772872688;2338.8947497362487;2339.865165394791;2305.5388922215457;2345.0971376020184;2350.012994542279;2363.8936247868714;2369.9052037918464;8633.913660863374;8673.566321683891;8701.303895688394;8734.912650873473;8762;5203.089459344599;5345.893082138375;5354.946450535523;5356.38401583819;5360.758765855546;3359.6304406515264;3382.729381649462;3412.0105169500816;3433.3133373325436;3469.3755124077657;1330.1686445971268;1369.890408767306;1396.5112210726265;1400.7198560287984;1412.2091628687865;11525.654230373102;11527.42362881861;11541.480633371602;11554.248973816675;11615.535378584931;4563.452385713736;4700.55344742249;4726.763661816895;4788.257820037899;4837.637177211724;9599.136077753035;9679.225661947028;9680.661176858775;9696.9030309696;9697.563609637584;5308.681479111188;5334.626576139633;5335.466453354711;5351.652142610717;5357.491038351351;4081.5102187737066;4860.6111511079025;4890.926636100461;4990.750462476934;5029.899402012013;3772.1512659651357;3843.55799083109;3874.41883717439;3893.124047089439;3927.155661532784;1108.9722756931142;1127.5264388956493;1128.0580715102817;1133.6939026462808;1141.4806263150247;965.8020105878278;987.151050096916;993.6770549571419;998.7852611688522;999.3604093380243;6011.128386384037;6044.365341639153;6120.938790612036;6184.752609895644;6221.5333849961435;1016.7174692814679;1027.3835698580792;1048.3814549415729;1056.8097742406287;1063.3885515828429;3616.8914932552066;3683.594804571495;3724.944125838115;3742.7941463219786;3756.2675278320467;9714.12572868431;9977.850332245021;10034.899651003543;10035.498225088717;10039.146672532917;9859.26055545837;9885.555150018266;9932.255080868963;9943.701688949199;9953.402795832273;7478.925210747823;7562.886556701544;7582.469227154156;7590.430717696195;7592.0130383050955;5199.454057324077;5371.435999220025;5375.59683023767;5452.318460192476;5461.399246082849;8486.10895855951;8544.102869198645;8596.656133754579;8638.697645582375;8771.035186129648;8832.425892316978;8885.689000884939;9023.458592484472;9068.682596109105;9159.49622770754;6365.1088847562305;6539.11721917554;6965.825854353681;7090.468214883801;7229.783106506813;8338.24955753985;8598.527081010605;8601.580739177965;8615.8707619387;8617.439866408664;7317.414606831547;7322.194558598657;7414.184439711736;7476.177620461854;7705.922940770521;7513.248675132443;7554;7631.465797394129;7647.808804779925;7647.88528172089;6729;6805.761798337035;6835.111435513351;6843.965780171067;6854.417374523022;4994.400671919393;5018.84943451697;5028.723420211923;5059.974700126476;5223.268742376146;5174.249733788655;5273.5781137509675;5317.1492561190025;5364.302640656846;5437.564994800327 04:50:18 INFO - PROCESS | 1716 | |4;prototype.html;390.45336528859593;393.3981009056144;402.0531647969033;413.7434790429934;419.329073482428;5340.359156901172;5409.29679141711;5411.134218525031;5421.6746995180265;5429.864253393667;5350.705711185883;5362.865928351793;5388.191771234317;5392;5395.946040539593;3915.138669492707;4206.957930420687;4214.936775948363;4243.68719048118;4254.744715317075;4214.957850421487;4221.746695198282;4227.949444519406;4238.7032907696475;4243.533211346765;4228;4229.661627069827;4229.915401691965;4234.9153016939645;4251.447311849471;4088.9182216355803;4200.726952748061;4202.718170957856;4218.789060546991;4254.191703576326;3801.201747633;3805.7145714071557;3842.4620553122586;3848.6343797339487;3853.3256680081154;5212.50481204285;5230.764615592308;5231.346081739783;5241.554467870235;5261.105612045923;4708.7174769513595;4887.633427492952;4914.483979182206;4924.655274130812;4925.556699896991;5598.776048958037;5610.298712660918;5620.606557540974;5621;5625.831225063254;4269.786510674454;4278.593533614302;4311.82752689892;4312.956870431318;4314.719543229711;5636;5789.710514474302;5797.159411885253;5836.912446313267;5888.735006924699;4205.2640787862;4205.876032603515;4210.494740631083;4225.366195070764;4230.576942305806;4251.107267473803;4257.638100761408;4263.253930562201;4288.807003684841;4306.82772689089;4740.762961851962;4782.210935195723;4802.375691160197;4855.927161092586;4874.683145595525;5638.802641907596;5649.209110724501;5652.802151924663;5673.461021203062;5675.943240567542;1433.605758416444;1440.942362305496;1441.657306876326;1445.169027809014;1446.3346860444312;931.2084727981162;994.7015895231547;998.1914649134225;999.2855108597388;1011.4841430870309;5420.214068959979;5421.756020979065;5423.701696406657;5426.9185962210595;5467.398586155519;5525.751341189656;5567.331920169606;5568.860778480571;5582.09730939909;5593.636413633182;5225.608079393985;5284.339457567804;5366.865828354323;5469.781208751605;5554.666719996813;2965.881364745429;2973.3458639099363;2974;2980.985095074511;2981.567672687448;5628.405484701446;5815;5856.00447923854;5877.941220587825;5906.40527057692;5584.357798853102;5676.318841739017;5680.478103575727;5707.714614269353;5741.282339707536;5865.208196893364;5931.102047344894;6015.669138197353;6022.488088512438;6034.24571928509;5753.3958934311295;5761.942380576308;5768.567357448292;5776.104703770922;5776.682282474504;5296.258523806747;5311.707856067954;5625.521830644441;5692.886142277214;5699.857503562444;5959.404059594006;5969.3732158122775;5985.25184351956;6001.879962400815;6014.428629280212;4166.375043743463;4198.5591512890705;4228.851990180329;4256.638185754246;4282.700210985201;5695.686737229492;5719.8570035749435;5724.112762521816;5741.91387129185;5748.195252664714;5579.6652200868075;5598.468145526169;5619.241402410622;5619.690916999441;5627.409122042127;5453.481919217668;5537.8061767837935;5556.222128901876;5590.189422533628;5632.9436705632415;5573.470520300727;5574.777008919597;5581.972090139523;5590.440955904377;5600.747966341606;5604.411536788579;5619.747111379916;5623.550115990793;5624.409437009219;5657.048318330169;5398.46015398457;5400.918986215132;5462.8361149165585;5512.448755124456;5521.613487055867 04:50:18 INFO - PROCESS | 1716 | |5;yui.html;836.736428025172;859.5100792548242;865.8657908024259;899.6131663384746;920.8848893888264;15924.68150636988;16673.749893751574;16773.580660483465;16800;16914.154292285384;16261.837381626181;16761;16849.32602695891;16865.915670421662;16917.83082169178;721.7329588052428;729.2379463460696;840.1472505407016;854.1543871567135;857.6826574167567;827.6275675945849;827.9917200828005;834.8288600836844;846.0777752250046;854.8760429737684;877.398981697536;887.6227603268617;888.3071204460531;888.5868071346822;889.2485849457231;750.2385079144673;760.7945854619277;879.3580686099151;879.612970293069;879.8768172455862;622.0420552349376;631.5579094633729;637.971291291893;643.1992169748646;643.8841008618447;16766.413175538797;16876.071816050113;16924.746128808078;16930.153492325335;16954.491365259062;14503.274836258144;14698.191599462025;15216.315265812955;15280.235988200546;15343.769843452357;13941.372638231303;14174.787378189336;14243.216623085726;14284;14352.56942291733;4481.170983368087;4592.839250626212;4593.104344652794;4599.655025873039;4725.8582242532775;76920.84618730667;77755;77857;79885;80960.59519702363;12350.691232719253;12369.381530923418;12445.191062580903;12500.374981250901;12517.123801334;24246.15138470145;24410.023599056192;24489.63265551018;24736.628950565755;24924.750752492244;8347.457415268109;8361;8496.830063398698;8519.659213631508;8664.826703465895;4531.161735079021;4661.603763680125;4680.063987202573;4896.706197628154;5067.1639179535705;3951.9012024699036;4042.4946881639794;4065.0447144920918;4066.959330406717;4069.4709687740406;663.2604645819972;664.0504079166838;666.2171947961126;681.6080753566719;684.852756657321;694.3854688600625;720.2797202797203;724.4168444402306;733.336330620789;738.2211766586196;10802.459877006118;11577.710557235969;11630;12047.216930899463;12205.572804951784;818.0061225610912;820.9835803283901;821.8479581277483;825.4593241426875;828.2090603473669;5350.250964864922;5436.972815135899;5480.369757477862;5515.586331025189;5557.888842223133;63954;64986.67506662436;67655;78812.60593696995;82541;58572;65607.67196163989;67955.98066029014;68119;69019.65490172617;60000.09999850006;60278.69860650669;60486.69756651277;60621.69689151614;60680;10669.733256668645;11071.1696622752;11157.66527004191;11264.09887209005;11330.546778128783;40182.79908600439;40614;40940;41389.58610413857;42820;50713;52414;53862;53885;54651.45348546463;12792.488300467878;13109.410076546388;13506.527271545448;13647.931760341531;13723.931380343034;16055.919720401324;16100.114493702958;16162.868599198413;16414.589635259214;17272.309107635552;14254.714905702036;14259.928700356431;14273.14361138335;14920.328585213474;14920.552383428514;13384.330783460593;13426.261555614145;13979.650508737363;14236.572902812932;14541.200233987232;14378.640533986734;14872.85127148758;14966.625834354229;15636.4527241546;15650.060996340257;11815.113866460222;11846.940765296118;12155.270683759003;12357.063814090656;12756.170848894792;10640.787184256425;11135.387553684624;11642;11790.351530665896;11930.582429614922 04:50:18 INFO - PROCESS | 1716 | __end_tp_report 04:50:18 INFO - PROCESS | 1716 | __start_cc_report 04:50:18 INFO - PROCESS | 1716 | _x_x_mozilla_cycle_collect,992 04:50:18 INFO - PROCESS | 1716 | __end_cc_report 04:50:18 INFO - PROCESS | 1716 | __startTimestamp1486731018453__endTimestamp 04:50:18 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | ------- Summary: start ------- 04:50:18 INFO - PROCESS | 1716 | Number of tests: 6 04:50:18 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | [#0] dojo.html Cycles:165 Average:5470.02 Median:5696.60 stddev:624.93 (11.0%) stddev-sans-first:603.14 04:50:18 INFO - PROCESS | 1716 | Values: 3296.4 3305.8 3335.5 3363.9 3373.6 5366.0 5445.9 5470.8 5471.0 5477.7 5457.9 5460.8 5473.6 5473.7 5478.3 4877.2 4896.8 4931.9 4954.0 4969.9 4877.2 4917.5 4968.4 4980.0 5009.2 4840.9 4887.2 4893.6 4924.7 5015.4 4992.4 5026.9 5029.8 5029.8 5046.9 4938.7 4950.3 4979.2 4995.8 5002.3 5210.1 5293.2 5362.7 5444.3 5448.3 5926.3 5927.3 5927.6 5927.9 5952.4 5905.9 5955.5 5962.7 5963.3 5971.3 5340.6 5382.5 5450.1 5493.1 5548.4 6035.7 6042.1 6045.6 6069.0 6071.6 5763.5 5808.8 5817.7 5822.8 5830.3 5685.4 5708.1 5716.1 5831.1 5834.8 5771.0 5797.0 5863.6 5890.4 5893.4 5864.3 5869.4 5873.2 5873.3 5879.1 4330.7 4345.3 4452.5 4460.4 4479.7 3977.9 4015.2 4028.4 4051.6 4092.7 5685.9 5689.3 5695.1 5698.4 5728.7 5720.0 5832.5 5856.1 5936.2 5951.7 5676.4 5747.7 5761.0 5780.0 5786.7 5032.2 5048.7 5097.1 5104.3 5127.5 6066.5 6120.4 6236.2 6260.2 6291.0 5859.4 5866.9 5871.7 5956.3 5992.6 6234.7 6260.7 6282.4 6294.2 6297.1 5590.4 5824.3 5882.9 5894.8 5927.1 5695.0 5798.8 5799.0 5803.4 5927.5 5691.8 5743.5 5746.7 5750.7 5755.8 5738.3 5738.5 5743.5 5745.1 5746.2 5596.8 5640.7 5642.7 5657.7 5672.8 5791.5 5805.3 5811.2 5812.1 5812.9 5676.6 5688.4 5690.6 5695.5 5696.6 04:50:18 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | [#1] ext.html Cycles:180 Average:50748.35 Median:384490.50 stddev:80280.42 (20.9%) stddev-sans-first:80417.33 04:50:18 INFO - PROCESS | 1716 | Values: 600.3 601.5 620.0 631.5 656.3 37846.0 48192.3 49562.8 49576.0 49600.0 51203.7 51629.5 51659.7 51733.2 51735.5 8690.2 9357.4 9554.5 9597.1 9598.4 8807.1 11178.7 11414.5 11439.4 11748.2 11378.7 11441.7 11453.0 11556.2 11583.8 11441.9 11493.3 11493.4 11504.7 11509.2 11257.6 11335.9 11338.0 11340.3 11341.4 47976.3 48099.0 48225.0 48280.8 48354.3 4320.8 4497.9 4514.1 4519.7 4717.7 32225.5 32274.5 32406.5 32705.3 33503.0 4673.3 4713.5 4728.0 4775.4 4811.6 322289.0 324788.4 326544.0 327122.0 327343.1 60941.4 61466.7 61841.0 61998.4 62055.4 65165.3 65296.7 65316.0 65344.7 65359.3 17855.0 18302.5 18311.6 18340.0 18373.6 13015.3 13256.6 13782.4 14076.2 14503.9 19298.2 19915.0 20389.4 20394.4 20415.2 7025.4 7133.6 7177.4 7252.0 7269.4 983.1 994.3 1002.4 1005.0 1005.6 33930.0 33981.2 34179.5 34219.0 34421.8 1100.8 1164.3 1184.7 1185.9 1208.5 18458.0 18470.0 18522.8 18547.6 18556.3 163527.0 163701.2 164009.0 164146.0 164396.0 70508.3 71180.3 71219.0 71332.6 71440.3 1551.9 1552.1 1554.9 1585.3 1599.9 33025.5 34413.8 34676.8 34709.3 34789.7 60626.1 61348.0 61376.4 61587.4 61613.4 384287.0 384317.0 384340.0 384641.0 384852.0 25634.0 25832.1 30930.4 32991.0 33345.3 52081.5 52335.2 52796.5 53195.5 53421.0 44901.8 45829.3 46078.0 46442.0 47241.0 44090.3 44302.6 45291.3 45983.5 46283.0 43883.8 43982.8 44235.6 44437.6 48096.8 43447.8 44562.0 47413.5 47751.2 49451.0 32752.2 34696.3 34711.5 34979.0 35285.5 04:50:18 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | [#2] jquery.html Cycles:180 Average:32634.67 Median:2887.45 stddev:93863.41 (3250.7%) stddev-sans-first:94095.48 04:50:18 INFO - PROCESS | 1716 | Values: 383.0 445.5 447.3 448.9 453.7 20062.6 20511.7 22002.0 22072.1 22450.2 21916.7 22100.9 22152.8 22215.9 22495.4 6094.3 6118.4 6202.3 6278.8 6320.7 6129.7 6225.3 6231.5 6233.7 6237.9 6049.4 6191.5 6197.0 6272.9 6318.8 6291.6 6417.3 6448.9 6451.6 6454.6 6346.8 6381.9 6396.1 6405.1 6410.5 26089.7 26478.3 26687.2 26891.3 26913.7 2823.8 2880.3 2881.3 2887.4 2887.5 10918.2 11246.8 11438.5 11440.4 11552.4 2066.8 2071.4 2118.9 2224.9 2226.8 88203.0 94053.5 95871.0 96836.0 103060.0 11407.8 12302.7 12401.8 12784.4 12829.3 16606.9 17093.6 17862.3 17868.3 18710.9 9035.2 9174.2 9285.8 9437.1 9468.7 8843.8 8917.0 8920.7 9073.9 9084.0 5460.2 5467.1 5523.1 5550.6 5595.8 2120.6 2129.7 2184.9 2193.2 2203.5 919.3 941.7 943.6 954.6 959.0 19519.0 21253.2 21487.1 21491.6 21548.4 945.8 951.8 957.7 961.5 961.9 11514.3 11765.4 11909.2 11967.0 12044.2 452355.0 461262.0 461701.0 665242.0 737635.0 89343.0 89674.0 93828.0 103227.5 118906.4 1135.8 1149.1 1188.7 1191.6 1192.9 19367.3 19372.9 19396.7 19693.7 19740.2 46142.0 46419.8 47850.0 47931.3 48146.0 65828.0 66024.0 66248.7 66426.7 66820.0 9510.0 9629.5 9630.7 9673.6 9755.7 13100.1 13671.1 13716.9 13897.9 13901.6 11734.8 11835.8 11975.6 12039.0 12040.5 12319.7 12339.1 12343.8 12457.6 12580.4 12316.5 12389.8 12400.3 12411.3 12466.8 9056.8 9180.0 9208.1 9444.9 9588.1 9429.6 12340.3 12563.7 12645.6 12658.5 04:50:18 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | [#3] mootools.html Cycles:180 Average:5545.45 Median:5340.68 stddev:2995.10 (56.1%) stddev-sans-first:2987.86 04:50:18 INFO - PROCESS | 1716 | Values: 1471.6 1488.0 1489.1 1506.8 1512.7 8152.6 8613.7 8618.9 8643.0 8697.4 7574.7 7790.8 8163.8 8400.8 8458.7 2365.4 2384.9 2386.3 2394.1 2401.3 2353.7 2365.8 2392.2 2392.5 2395.1 2316.8 2322.6 2344.9 2346.3 2347.9 2263.8 2308.3 2317.3 2338.9 2339.9 2305.5 2345.1 2350.0 2363.9 2369.9 8633.9 8673.6 8701.3 8734.9 8762.0 5203.1 5345.9 5354.9 5356.4 5360.8 3359.6 3382.7 3412.0 3433.3 3469.4 1330.2 1369.9 1396.5 1400.7 1412.2 11525.7 11527.4 11541.5 11554.2 11615.5 4563.5 4700.6 4726.8 4788.3 4837.6 9599.1 9679.2 9680.7 9696.9 9697.6 5308.7 5334.6 5335.5 5351.7 5357.5 4081.5 4860.6 4890.9 4990.8 5029.9 3772.2 3843.6 3874.4 3893.1 3927.2 1109.0 1127.5 1128.1 1133.7 1141.5 965.8 987.2 993.7 998.8 999.4 6011.1 6044.4 6120.9 6184.8 6221.5 1016.7 1027.4 1048.4 1056.8 1063.4 3616.9 3683.6 3724.9 3742.8 3756.3 9714.1 9977.9 10034.9 10035.5 10039.1 9859.3 9885.6 9932.3 9943.7 9953.4 7478.9 7562.9 7582.5 7590.4 7592.0 5199.5 5371.4 5375.6 5452.3 5461.4 8486.1 8544.1 8596.7 8638.7 8771.0 8832.4 8885.7 9023.5 9068.7 9159.5 6365.1 6539.1 6965.8 7090.5 7229.8 8338.2 8598.5 8601.6 8615.9 8617.4 7317.4 7322.2 7414.2 7476.2 7705.9 7513.2 7554.0 7631.5 7647.8 7647.9 6729.0 6805.8 6835.1 6844.0 6854.4 4994.4 5018.8 5028.7 5060.0 5223.3 5174.2 5273.6 5317.1 5364.3 5437.6 04:50:18 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | [#4] prototype.html Cycles:180 Average:4747.86 Median:5415.67 stddev:1362.99 (25.2%) stddev-sans-first:1327.00 04:50:18 INFO - PROCESS | 1716 | Values: 390.5 393.4 402.1 413.7 419.3 5340.4 5409.3 5411.1 5421.7 5429.9 5350.7 5362.9 5388.2 5392.0 5395.9 3915.1 4207.0 4214.9 4243.7 4254.7 4215.0 4221.7 4227.9 4238.7 4243.5 4228.0 4229.7 4229.9 4234.9 4251.4 4088.9 4200.7 4202.7 4218.8 4254.2 3801.2 3805.7 3842.5 3848.6 3853.3 5212.5 5230.8 5231.3 5241.6 5261.1 4708.7 4887.6 4914.5 4924.7 4925.6 5598.8 5610.3 5620.6 5621.0 5625.8 4269.8 4278.6 4311.8 4313.0 4314.7 5636.0 5789.7 5797.2 5836.9 5888.7 4205.3 4205.9 4210.5 4225.4 4230.6 4251.1 4257.6 4263.3 4288.8 4306.8 4740.8 4782.2 4802.4 4855.9 4874.7 5638.8 5649.2 5652.8 5673.5 5675.9 1433.6 1440.9 1441.7 1445.2 1446.3 931.2 994.7 998.2 999.3 1011.5 5420.2 5421.8 5423.7 5426.9 5467.4 5525.8 5567.3 5568.9 5582.1 5593.6 5225.6 5284.3 5366.9 5469.8 5554.7 2965.9 2973.3 2974.0 2981.0 2981.6 5628.4 5815.0 5856.0 5877.9 5906.4 5584.4 5676.3 5680.5 5707.7 5741.3 5865.2 5931.1 6015.7 6022.5 6034.2 5753.4 5761.9 5768.6 5776.1 5776.7 5296.3 5311.7 5625.5 5692.9 5699.9 5959.4 5969.4 5985.3 6001.9 6014.4 4166.4 4198.6 4228.9 4256.6 4282.7 5695.7 5719.9 5724.1 5741.9 5748.2 5579.7 5598.5 5619.2 5619.7 5627.4 5453.5 5537.8 5556.2 5590.2 5632.9 5573.5 5574.8 5582.0 5590.4 5600.7 5604.4 5619.7 5623.6 5624.4 5657.0 5398.5 5400.9 5462.8 5512.4 5521.6 04:50:18 INFO - PROCESS | 1716 | 04:50:18 INFO - PROCESS | 1716 | [#5] yui.html Cycles:180 Average:17815.85 Median:4506.17 stddev:21326.85 (473.3%) stddev-sans-first:21348.56 04:50:18 INFO - PROCESS | 1716 | Values: 836.7 859.5 865.9 899.6 920.9 15924.7 16673.7 16773.6 16800.0 16914.2 16261.8 16761.0 16849.3 16865.9 16917.8 721.7 729.2 840.1 854.2 857.7 827.6 828.0 834.8 846.1 854.9 877.4 887.6 888.3 888.6 889.2 750.2 760.8 879.4 879.6 879.9 622.0 631.6 638.0 643.2 643.9 16766.4 16876.1 16924.7 16930.2 16954.5 14503.3 14698.2 15216.3 15280.2 15343.8 13941.4 14174.8 14243.2 14284.0 14352.6 4481.2 4592.8 4593.1 4599.7 4725.9 76920.8 77755.0 77857.0 79885.0 80960.6 12350.7 12369.4 12445.2 12500.4 12517.1 24246.2 24410.0 24489.6 24736.6 24924.8 8347.5 8361.0 8496.8 8519.7 8664.8 4531.2 4661.6 4680.1 4896.7 5067.2 3951.9 4042.5 4065.0 4067.0 4069.5 663.3 664.1 666.2 681.6 684.9 694.4 720.3 724.4 733.3 738.2 10802.5 11577.7 11630.0 12047.2 12205.6 818.0 821.0 821.8 825.5 828.2 5350.3 5437.0 5480.4 5515.6 5557.9 63954.0 64986.7 67655.0 78812.6 82541.0 58572.0 65607.7 67956.0 68119.0 69019.7 60000.1 60278.7 60486.7 60621.7 60680.0 10669.7 11071.2 11157.7 11264.1 11330.5 40182.8 40614.0 40940.0 41389.6 42820.0 50713.0 52414.0 53862.0 53885.0 54651.5 12792.5 13109.4 13506.5 13647.9 13723.9 16055.9 16100.1 16162.9 16414.6 17272.3 14254.7 14259.9 14273.1 14920.3 14920.6 13384.3 13426.3 13979.7 14236.6 14541.2 14378.6 14872.9 14966.6 15636.5 15650.1 11815.1 11846.9 12155.3 12357.1 12756.2 10640.8 11135.4 11642.0 11790.4 11930.6 04:50:18 INFO - PROCESS | 1716 | -------- Summary: end -------- 04:50:18 INFO - PROCESS | 1716 | 04:50:19 INFO - TEST-INFO | 1716: exit 0 04:50:19 INFO - TEST-OK | dromaeo_css | took 1113778ms 04:50:19 INFO - TEST-START | kraken 04:50:19 INFO - operating with platform_type : linux_ 04:50:19 INFO - Initialising browser for kraken test... 04:50:19 INFO - TEST-INFO | started process 2031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO_S2Z8/profile http://localhost:32964/getInfo.html) 04:50:23 INFO - PROCESS | 2031 | __metrics Screen width/height:1600/1200 04:50:23 INFO - PROCESS | 2031 | colorDepth:24 04:50:23 INFO - PROCESS | 2031 | Browser inner width/height: 1024/697 04:50:23 INFO - PROCESS | 2031 | __metrics 04:50:23 INFO - PROCESS | 2031 | 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" 04:50:23 INFO - PROCESS | 2031 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:24 INFO - PROCESS | 2031 | console.error: PushService: 04:50:24 INFO - PROCESS | 2031 | stateChangeProcessEnqueue: Error transitioning state 04:50:24 INFO - PROCESS | 2031 | UnknownError 04:50:24 INFO - TEST-INFO | 2031: exit 0 04:50:24 INFO - Browser initialized. 04:50:24 INFO - Running cycle 1/1 for kraken test... 04:50:24 INFO - TEST-INFO | started process 2124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO_S2Z8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:36 INFO - PROCESS | 2124 | RSS: Main: 138256384 04:50:36 INFO - PROCESS | 2124 | 04:50:39 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32964/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:40 INFO - PROCESS | 2124 | RSS: Main: 181858304 04:50:40 INFO - PROCESS | 2124 | 04:50:42 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32964/tests/kraken/driver.html?testName=audio-dft) 04:50:43 INFO - PROCESS | 2124 | RSS: Main: 171593728 04:50:43 INFO - PROCESS | 2124 | 04:50:45 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32964/tests/kraken/driver.html?testName=audio-fft) 04:50:46 INFO - PROCESS | 2124 | RSS: Main: 263876608 04:50:46 INFO - PROCESS | 2124 | 04:50:48 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32964/tests/kraken/driver.html?testName=audio-oscillator) 04:50:49 INFO - PROCESS | 2124 | RSS: Main: 170315776 04:50:49 INFO - PROCESS | 2124 | 04:50:51 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32964/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:51 INFO - PROCESS | 2124 | RSS: Main: 173068288 04:50:51 INFO - PROCESS | 2124 | 04:50:54 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32964/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:55 INFO - PROCESS | 2124 | RSS: Main: 212066304 04:50:55 INFO - PROCESS | 2124 | 04:50:58 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32964/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:59 INFO - PROCESS | 2124 | RSS: Main: 210096128 04:50:59 INFO - PROCESS | 2124 | 04:51:02 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32964/tests/kraken/driver.html?testName=json-parse-financial) 04:51:02 INFO - PROCESS | 2124 | RSS: Main: 208756736 04:51:02 INFO - PROCESS | 2124 | 04:51:04 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32964/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:04 INFO - PROCESS | 2124 | RSS: Main: 171192320 04:51:04 INFO - PROCESS | 2124 | 04:51:06 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32964/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:07 INFO - PROCESS | 2124 | RSS: Main: 178667520 04:51:07 INFO - PROCESS | 2124 | 04:51:09 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32964/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:09 INFO - PROCESS | 2124 | RSS: Main: 186642432 04:51:09 INFO - PROCESS | 2124 | 04:51:12 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:12 INFO - PROCESS | 2124 | RSS: Main: 196886528 04:51:12 INFO - PROCESS | 2124 | 04:51:15 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:16 INFO - PROCESS | 2124 | RSS: Main: 193277952 04:51:16 INFO - PROCESS | 2124 | 04:51:17 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:32964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32964/tests/kraken/driver.html?testName=ai-astar) 04:51:18 INFO - PROCESS | 2124 | RSS: Main: 244346880 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | __start_tp_report 04:51:18 INFO - PROCESS | 2124 | _x_x_mozilla_page_load 04:51:18 INFO - PROCESS | 2124 | _x_x_mozilla_page_load_details 04:51:18 INFO - PROCESS | 2124 | |i|pagename|runs| 04:51:18 INFO - PROCESS | 2124 | |0;ai-astar;110;111;111;112;112;113;110;112;111;112 04:51:18 INFO - PROCESS | 2124 | |1;audio-beat-detection;147;126;115;154;122;124;123;116;137;118 04:51:18 INFO - PROCESS | 2124 | |2;audio-dft;160;160;161;160;162;160;160;161;160;161 04:51:18 INFO - PROCESS | 2124 | |3;audio-fft;75;75;76;108;75;76;75;79;101;77 04:51:18 INFO - PROCESS | 2124 | |4;audio-oscillator;82;82;102;83;82;83;97;83;82;109 04:51:18 INFO - PROCESS | 2124 | |5;imaging-gaussian-blur;117;117;117;118;117;117;116;117;117;117 04:51:18 INFO - PROCESS | 2124 | |6;imaging-darkroom;146;146;147;146;147;146;147;147;147;147 04:51:18 INFO - PROCESS | 2124 | |7;imaging-desaturate;96;96;95;95;95;96;95;95;95;96 04:51:18 INFO - PROCESS | 2124 | |8;json-parse-financial;51;49;49;49;49;49;50;48;49;48 04:51:18 INFO - PROCESS | 2124 | |9;json-stringify-tinderbox;62;63;63;63;63;63;63;63;64;62 04:51:18 INFO - PROCESS | 2124 | |10;stanford-crypto-aes;75;75;76;76;76;79;76;75;75;75 04:51:18 INFO - PROCESS | 2124 | |11;stanford-crypto-ccm;126;130;130;124;120;118;130;134;153;126 04:51:18 INFO - PROCESS | 2124 | |12;stanford-crypto-pbkdf2;159;156;155;158;157;159;159;161;159;160 04:51:18 INFO - PROCESS | 2124 | |13;stanford-crypto-sha256-iterative;60;62;61;60;61;58;66;60;61;58 04:51:18 INFO - PROCESS | 2124 | __end_tp_report 04:51:18 INFO - PROCESS | 2124 | __start_cc_report 04:51:18 INFO - PROCESS | 2124 | _x_x_mozilla_cycle_collect,1520 04:51:18 INFO - PROCESS | 2124 | __end_cc_report 04:51:18 INFO - PROCESS | 2124 | __startTimestamp1486731078109__endTimestamp 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | ------- Summary: start ------- 04:51:18 INFO - PROCESS | 2124 | Number of tests: 14 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 04:51:18 INFO - PROCESS | 2124 | Values: 110.0 111.0 111.0 112.0 112.0 113.0 110.0 112.0 111.0 112.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:125.00 stddev:13.38 (10.7%) stddev-sans-first:12.34 04:51:18 INFO - PROCESS | 2124 | Values: 147.0 126.0 115.0 154.0 122.0 124.0 123.0 116.0 137.0 118.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 04:51:18 INFO - PROCESS | 2124 | Values: 160.0 160.0 161.0 160.0 162.0 160.0 160.0 161.0 160.0 161.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:12.19 (16.2%) stddev-sans-first:12.69 04:51:18 INFO - PROCESS | 2124 | Values: 75.0 75.0 76.0 108.0 75.0 76.0 75.0 79.0 101.0 77.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:82.50 stddev:10.19 (12.4%) stddev-sans-first:10.53 04:51:18 INFO - PROCESS | 2124 | Values: 82.0 82.0 102.0 83.0 82.0 83.0 97.0 83.0 82.0 109.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:51:18 INFO - PROCESS | 2124 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:51:18 INFO - PROCESS | 2124 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:51:18 INFO - PROCESS | 2124 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:0.88 (1.8%) stddev-sans-first:0.60 04:51:18 INFO - PROCESS | 2124 | Values: 51.0 49.0 49.0 49.0 49.0 49.0 50.0 48.0 49.0 48.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 04:51:18 INFO - PROCESS | 2124 | Values: 62.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 62.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.23 (1.6%) stddev-sans-first:1.27 04:51:18 INFO - PROCESS | 2124 | Values: 75.0 75.0 76.0 76.0 76.0 79.0 76.0 75.0 75.0 75.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:130.00 stddev:9.71 (7.5%) stddev-sans-first:10.24 04:51:18 INFO - PROCESS | 2124 | Values: 126.0 130.0 130.0 124.0 120.0 118.0 130.0 134.0 153.0 126.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.00 stddev:1.83 (1.2%) stddev-sans-first:1.92 04:51:18 INFO - PROCESS | 2124 | Values: 159.0 156.0 155.0 158.0 157.0 159.0 159.0 161.0 159.0 160.0 04:51:18 INFO - PROCESS | 2124 | 04:51:18 INFO - PROCESS | 2124 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:61.00 stddev:2.26 (3.7%) stddev-sans-first:2.39 04:51:18 INFO - PROCESS | 2124 | Values: 60.0 62.0 61.0 60.0 61.0 58.0 66.0 60.0 61.0 58.0 04:51:18 INFO - PROCESS | 2124 | -------- Summary: end -------- 04:51:18 INFO - PROCESS | 2124 | 04:51:19 INFO - TEST-INFO | 2124: exit 0 04:51:19 INFO - TEST-OK | kraken | took 59950ms 04:51:19 INFO - SUITE-END | took 1173s 04:51:19 INFO - Completed test suite (00:19:33) 04:51:19 INFO - javascript benchmark 04:51:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.4066468035753, 3305.752068594856, 3335.483000134979, 3363.89908302751, 3373.595168579771, 5366.0, 5445.945540544599, 5470.781168753255, 5471.0, 5477.726113694314, 5457.863553411166, 5460.754266058027, 5473.589480788937, 5473.698946557938, 5478.342598888129, 4877.244027175793, 4896.77964491597, 4931.852044438655, 4953.950460495403, 4969.900601987958, 4877.244027175793, 4917.45907950127, 4968.40379154502, 4979.975100124512, 5009.248612708105, 4840.87897802556, 4887.193613053842, 4893.559579637832, 4924.70451772893, 5015.3730783652045, 4992.350994370745, 5026.924596131079, 5029.773660185264, 5029.849104526834, 5046.899062018739, 4938.703677779345, 4950.331705219785, 4979.2282196259275, 4995.825146119904, 5002.324686167357, 5210.114280572312, 5293.153095504739, 5362.6782393056155, 5444.346678398578, 5448.346198456171, 5926.288845338544, 5927.2590926134235, 5927.644341339534, 5927.851803704899, 5952.375000624916, 5905.8818823623715, 5955.464008239279, 5962.731677074542, 5963.314218864843, 5971.253593300838, 5340.599455040888, 5382.4886635769535, 5450.127979523258, 5493.148561972901, 5548.361938377098, 6035.698215089228, 6042.12389203563, 6045.6070355426755, 6069.0, 6071.605345652519, 5763.4812866842185, 5808.79669211584, 5817.7091145442555, 5822.82531524055, 5830.271216097988, 5685.431456854364, 5708.086706127083, 5716.056850619684, 5831.125331200269, 5834.766609335579, 5771.0, 5797.0, 5863.589548731633, 5890.352061273256, 5893.351731309553, 5864.325602555676, 5869.442402971711, 5873.236479257669, 5873.295204575393, 5879.088741245114, 4330.740155590612, 4345.326474396474, 4452.510223875371, 4460.375547423363, 4479.70881892676, 3977.8607748729232, 4015.2371049500503, 4028.3756017817286, 4051.5948405159247, 4092.6725861930972, 5685.943140568541, 5689.2603961485565, 5695.117256825199, 5698.430156984351, 5728.742206600713, 5719.999000174953, 5832.533397328203, 5856.121581762684, 5936.1986131871645, 5951.672658003851, 5676.375598684142, 5747.712614369265, 5761.0, 5780.046292361797, 5786.710664466844, 5032.169692000779, 5048.697078175248, 5097.133487307166, 5104.259882317117, 5127.461616530285, 6066.48434883031, 6120.387961204022, 6236.220472440945, 6260.248770147611, 6291.0, 5859.44335288147, 5866.911996319973, 5871.6770577616935, 5956.255468066492, 5992.580519363602, 6234.657093859882, 6260.7495700171485, 6282.403171698681, 6294.181756371642, 6297.118403423616, 5590.385057643737, 5824.330202026821, 5882.911756323744, 5894.764209431574, 5927.110933360031, 5695.0, 5798.76804927815, 5799.0, 5803.419658034163, 5927.4665280125, 5691.8292451226525, 5743.483086522233, 5746.712664366682, 5750.741216645178, 5755.798547050833, 5738.282714660668, 5738.483536481736, 5743.540516758566, 5745.052066408995, 5746.195532625519, 5596.776128954796, 5640.746166422438, 5642.7460764266525, 5657.688827114548, 5672.801451949162, 5791.507721843691, 5805.274340707411, 5811.157382179645, 5812.128180772918, 5812.912806307824, 5676.602637815313, 5688.40271771458, 5690.573207009408, 5695.487406133468, 5696.601237913306], "value": 5428.811969645583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.2586805295459, 601.5007543738694, 619.9814005579834, 631.5295105146666, 656.3075954867613, 37846.0, 48192.277115843244, 49562.75218623911, 49576.0, 49600.007999840025, 51203.74398128013, 51629.48370516294, 51659.74170129153, 51733.22400164, 51735.482645173535, 8690.174433428814, 9357.438553686783, 9554.522273886312, 9597.136257736802, 9598.376105553152, 8807.07525709801, 11178.720531986684, 11414.543418263302, 11439.370834604093, 11748.236364636314, 11378.658640240807, 11441.713957151054, 11453.0, 11556.191066625339, 11583.768324633502, 11441.885581144206, 11493.252938558968, 11493.367864767435, 11504.654860354203, 11509.194356395055, 11257.605983790529, 11335.886641133566, 11338.0, 11340.319580825177, 11341.432928353632, 47976.28035579469, 48099.03801923942, 48225.0, 48280.758596207146, 48354.27468587974, 4320.848770293024, 4497.9325310120375, 4514.0971805639, 4519.661025423106, 4717.669763116583, 32225.51661725076, 32274.515882261785, 32406.513902291485, 32705.345893082005, 33503.0, 4673.345731597579, 4713.505081966378, 4728.0, 4775.403074615673, 4811.615070794328, 322289.0, 324788.3760581206, 326544.0, 327122.0, 327343.0898536524, 60941.39058609446, 61466.69266653638, 61841.0, 61998.380016200164, 62055.379446205865, 65165.348346516876, 65296.67351663306, 65316.0, 65344.673276633315, 65359.346406535326, 17855.0, 18302.450926472226, 18311.63376732458, 18340.0, 18373.63252734938, 13015.349232538525, 13256.602301930765, 13782.448702051806, 14076.155430674193, 14503.927480362741, 19298.22807087729, 19915.0, 20389.388318350473, 20394.388168354973, 20415.183392664127, 7025.367716905503, 7133.607651579213, 7177.354038136593, 7251.963740181371, 7269.382102521239, 983.1004630762915, 994.2592768387598, 1002.4035698759227, 1004.9949750251202, 1005.5726316315537, 33929.994421866344, 33981.15047123842, 34179.487307690404, 34219.0, 34421.82789086038, 1100.779844031197, 1164.3194358678236, 1184.7452797648548, 1185.934773587461, 1208.486393282869, 18458.0, 18470.0, 18522.81477185211, 18547.629047418977, 18556.257749689863, 163527.0, 163701.18149409175, 164009.0, 164146.0, 164396.0, 70508.29491705017, 71180.28819711736, 71219.0, 71332.64333678299, 71440.28559714336, 1551.8603325700515, 1552.0765144738862, 1554.8678362339328, 1585.2866210205223, 1599.928003239857, 33025.50461743124, 34413.827930860185, 34676.82661586676, 34709.305813883075, 34789.65210347864, 60626.09060864179, 61348.0, 61376.38623613707, 61587.38412615816, 61613.383866160766, 384287.0, 384317.0, 384340.0, 384641.0, 384852.0, 25633.97464101415, 25832.095876644227, 30930.381392371575, 32991.0, 33345.333093338486, 52081.47918520766, 52335.214971774694, 52796.47203528069, 53195.46804531905, 53421.0, 44901.77549112234, 45829.31256031229, 46078.0, 46442.0, 47241.0, 44090.338644920994, 44302.556974431136, 45291.320630191236, 45983.54016459793, 46283.0, 43883.78058109689, 43982.78008610065, 44235.55764442314, 44437.55562444334, 48096.7595162022, 43447.78276108599, 44562.0, 47413.52586474229, 47751.179905608165, 49451.0, 32752.181195470304, 34696.306073878884, 34711.47932781061, 34978.95063148109, 35285.47071793874], "value": 21510.218820548984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.0232906089471, 445.5366418924319, 447.25085481817956, 448.92817149256115, 453.7209616086108, 20062.59874802503, 20511.692324615142, 22002.0, 22072.11711531541, 22450.214242501515, 21916.671249931263, 22100.88949555254, 22152.778472215272, 22215.888920555415, 22495.437614059658, 6094.299155597097, 6118.418750218733, 6202.317745048041, 6278.780242691507, 6320.683965801714, 6129.662868542228, 6225.3463386344465, 6231.5326350523665, 6233.71948262327, 6237.875242495147, 6049.395060493959, 6191.473724733403, 6197.008478643418, 6272.905906411407, 6318.8104356869135, 6291.591046582003, 6417.26201486828, 6448.903266451007, 6451.645159516224, 6454.644994525299, 6346.777862774781, 6381.93618063818, 6396.1045453636525, 6405.103285540028, 6410.519211059142, 26089.73910260892, 26478.338041548923, 26687.19938401851, 26891.32771680704, 26913.730862691318, 2823.8446885421295, 2880.323124065843, 2881.2940829496697, 2887.422515496888, 2887.4802535543595, 10918.235723499358, 11246.831297530543, 11438.485268162869, 11440.370779607118, 11552.422378881107, 2066.844986625994, 2071.4407110080347, 2118.9152433902777, 2224.9443763906033, 2226.76618955009, 88203.0, 94053.52973235158, 95871.0, 96836.0, 103060.0, 11407.828882566768, 12302.692432689255, 12401.813972790414, 12784.360781960864, 12829.294388808705, 16606.916965415337, 17093.572660683334, 17862.28550857977, 17868.28526858937, 18710.906445467685, 9035.232005279493, 9174.174324310845, 9285.814283714422, 9437.103475169848, 9468.715938521855, 8843.823123537493, 8917.0, 8920.687775927941, 9073.863892041625, 9083.954580227057, 5460.208269800856, 5467.125259958467, 5523.143912693539, 5550.55595552363, 5595.804146854841, 2120.6182887080167, 2129.6592545192693, 2184.8798316092766, 2193.1994821889894, 2203.471166919928, 919.2508105893676, 941.7316064921602, 943.6084025129494, 954.6038394066385, 958.9568469418892, 19519.0, 21253.21684112389, 21487.140514379564, 21491.570168596852, 21548.35354939354, 945.772705279058, 951.7906060666643, 957.7461972577272, 961.4663861556903, 961.9086186812242, 11514.30914145154, 11765.352905590275, 11909.22590031645, 11967.042636589053, 12044.156909016285, 452355.0, 461262.0, 461701.0, 665242.0, 737635.0, 89343.0, 89674.0, 93828.0, 103227.48386258021, 118906.4054679721, 1135.778523187987, 1149.0520320735427, 1188.6790566547156, 1191.5769901684778, 1192.9164958452825, 19367.3221437249, 19372.903135484234, 19396.709049363988, 19693.704594431383, 19740.210391584176, 46142.0, 46419.76790116028, 47850.0, 47931.281030783866, 48146.0, 65828.0, 66024.0, 66248.66875665591, 66426.66786666035, 66819.99310030963, 9509.952450237704, 9629.470379129216, 9630.711078667651, 9673.564689588844, 9755.658551950648, 13100.082994190696, 13671.111377760413, 13716.862831371558, 13897.930510347383, 13901.58295251144, 11734.823977640172, 11835.763284734085, 11975.580854670045, 12039.0, 12040.518379264731, 12319.692007699521, 12339.07456940715, 12343.753124937271, 12457.626271211879, 12580.370981451073, 12316.50733970667, 12389.75220495567, 12400.255984640951, 12411.255324680187, 12466.812997805222, 9056.773580660536, 9180.0, 9208.12522810332, 9444.905550944677, 9588.137067663944, 9429.62281508732, 12340.259584424963, 12563.685907852378, 12645.557405490763, 12658.493660253487], "value": 10173.264233828988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.6320919770058, 1487.970240595189, 1489.069331667708, 1506.8493150684933, 1512.6974605078985, 8152.59237038148, 8613.655453781857, 8618.913810861904, 8643.0, 8697.391182617219, 7574.734884279052, 7790.805229869256, 8163.836723265546, 8400.83198336033, 8458.746237612866, 2365.373176108328, 2384.9284521464383, 2386.296042667417, 2394.1022116706235, 2401.327628264089, 2353.705786776653, 2365.7515960824126, 2392.234484964812, 2392.5334559760854, 2395.1138078910826, 2316.756740542244, 2322.593546129429, 2344.9413764655933, 2346.3195673254822, 2347.9178228762, 2263.7509873913855, 2308.2959697292317, 2317.2584772872688, 2338.8947497362487, 2339.865165394791, 2305.5388922215457, 2345.0971376020184, 2350.012994542279, 2363.8936247868714, 2369.9052037918464, 8633.913660863374, 8673.566321683891, 8701.303895688394, 8734.912650873473, 8762.0, 5203.089459344599, 5345.893082138375, 5354.946450535523, 5356.38401583819, 5360.758765855546, 3359.6304406515264, 3382.729381649462, 3412.0105169500816, 3433.3133373325436, 3469.3755124077657, 1330.1686445971268, 1369.890408767306, 1396.5112210726265, 1400.7198560287984, 1412.2091628687865, 11525.654230373102, 11527.42362881861, 11541.480633371602, 11554.248973816675, 11615.535378584931, 4563.452385713736, 4700.55344742249, 4726.763661816895, 4788.257820037899, 4837.637177211724, 9599.136077753035, 9679.225661947028, 9680.661176858775, 9696.9030309696, 9697.563609637584, 5308.681479111188, 5334.626576139633, 5335.466453354711, 5351.652142610717, 5357.491038351351, 4081.5102187737066, 4860.6111511079025, 4890.926636100461, 4990.750462476934, 5029.899402012013, 3772.1512659651357, 3843.55799083109, 3874.41883717439, 3893.124047089439, 3927.155661532784, 1108.9722756931142, 1127.5264388956493, 1128.0580715102817, 1133.6939026462808, 1141.4806263150247, 965.8020105878278, 987.151050096916, 993.6770549571419, 998.7852611688522, 999.3604093380243, 6011.128386384037, 6044.365341639153, 6120.938790612036, 6184.752609895644, 6221.5333849961435, 1016.7174692814679, 1027.3835698580792, 1048.3814549415729, 1056.8097742406287, 1063.3885515828429, 3616.8914932552066, 3683.594804571495, 3724.944125838115, 3742.7941463219786, 3756.2675278320467, 9714.12572868431, 9977.850332245021, 10034.899651003543, 10035.498225088717, 10039.146672532917, 9859.26055545837, 9885.555150018266, 9932.255080868963, 9943.701688949199, 9953.402795832273, 7478.925210747823, 7562.886556701544, 7582.469227154156, 7590.430717696195, 7592.0130383050955, 5199.454057324077, 5371.435999220025, 5375.59683023767, 5452.318460192476, 5461.399246082849, 8486.10895855951, 8544.102869198645, 8596.656133754579, 8638.697645582375, 8771.035186129648, 8832.425892316978, 8885.689000884939, 9023.458592484472, 9068.682596109105, 9159.49622770754, 6365.1088847562305, 6539.11721917554, 6965.825854353681, 7090.468214883801, 7229.783106506813, 8338.24955753985, 8598.527081010605, 8601.580739177965, 8615.8707619387, 8617.439866408664, 7317.414606831547, 7322.194558598657, 7414.184439711736, 7476.177620461854, 7705.922940770521, 7513.248675132443, 7554.0, 7631.465797394129, 7647.808804779925, 7647.88528172089, 6729.0, 6805.761798337035, 6835.111435513351, 6843.965780171067, 6854.417374523022, 4994.400671919393, 5018.84943451697, 5028.723420211923, 5059.974700126476, 5223.268742376146, 5174.249733788655, 5273.5781137509675, 5317.1492561190025, 5364.302640656846, 5437.564994800327], "value": 4530.832185746674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.45336528859593, 393.3981009056144, 402.0531647969033, 413.7434790429934, 419.329073482428, 5340.359156901172, 5409.29679141711, 5411.134218525031, 5421.6746995180265, 5429.864253393667, 5350.705711185883, 5362.865928351793, 5388.191771234317, 5392.0, 5395.946040539593, 3915.138669492707, 4206.957930420687, 4214.936775948363, 4243.68719048118, 4254.744715317075, 4214.957850421487, 4221.746695198282, 4227.949444519406, 4238.7032907696475, 4243.533211346765, 4228.0, 4229.661627069827, 4229.915401691965, 4234.9153016939645, 4251.447311849471, 4088.9182216355803, 4200.726952748061, 4202.718170957856, 4218.789060546991, 4254.191703576326, 3801.201747633, 3805.7145714071557, 3842.4620553122586, 3848.6343797339487, 3853.3256680081154, 5212.50481204285, 5230.764615592308, 5231.346081739783, 5241.554467870235, 5261.105612045923, 4708.7174769513595, 4887.633427492952, 4914.483979182206, 4924.655274130812, 4925.556699896991, 5598.776048958037, 5610.298712660918, 5620.606557540974, 5621.0, 5625.831225063254, 4269.786510674454, 4278.593533614302, 4311.82752689892, 4312.956870431318, 4314.719543229711, 5636.0, 5789.710514474302, 5797.159411885253, 5836.912446313267, 5888.735006924699, 4205.2640787862, 4205.876032603515, 4210.494740631083, 4225.366195070764, 4230.576942305806, 4251.107267473803, 4257.638100761408, 4263.253930562201, 4288.807003684841, 4306.82772689089, 4740.762961851962, 4782.210935195723, 4802.375691160197, 4855.927161092586, 4874.683145595525, 5638.802641907596, 5649.209110724501, 5652.802151924663, 5673.461021203062, 5675.943240567542, 1433.605758416444, 1440.942362305496, 1441.657306876326, 1445.169027809014, 1446.3346860444312, 931.2084727981162, 994.7015895231547, 998.1914649134225, 999.2855108597388, 1011.4841430870309, 5420.214068959979, 5421.756020979065, 5423.701696406657, 5426.9185962210595, 5467.398586155519, 5525.751341189656, 5567.331920169606, 5568.860778480571, 5582.09730939909, 5593.636413633182, 5225.608079393985, 5284.339457567804, 5366.865828354323, 5469.781208751605, 5554.666719996813, 2965.881364745429, 2973.3458639099363, 2974.0, 2980.985095074511, 2981.567672687448, 5628.405484701446, 5815.0, 5856.00447923854, 5877.941220587825, 5906.40527057692, 5584.357798853102, 5676.318841739017, 5680.478103575727, 5707.714614269353, 5741.282339707536, 5865.208196893364, 5931.102047344894, 6015.669138197353, 6022.488088512438, 6034.24571928509, 5753.3958934311295, 5761.942380576308, 5768.567357448292, 5776.104703770922, 5776.682282474504, 5296.258523806747, 5311.707856067954, 5625.521830644441, 5692.886142277214, 5699.857503562444, 5959.404059594006, 5969.3732158122775, 5985.25184351956, 6001.879962400815, 6014.428629280212, 4166.375043743463, 4198.5591512890705, 4228.851990180329, 4256.638185754246, 4282.700210985201, 5695.686737229492, 5719.8570035749435, 5724.112762521816, 5741.91387129185, 5748.195252664714, 5579.6652200868075, 5598.468145526169, 5619.241402410622, 5619.690916999441, 5627.409122042127, 5453.481919217668, 5537.8061767837935, 5556.222128901876, 5590.189422533628, 5632.9436705632415, 5573.470520300727, 5574.777008919597, 5581.972090139523, 5590.440955904377, 5600.747966341606, 5604.411536788579, 5619.747111379916, 5623.550115990793, 5624.409437009219, 5657.048318330169, 5398.46015398457, 5400.918986215132, 5462.8361149165585, 5512.448755124456, 5521.613487055867], "value": 4330.934779789533, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [836.736428025172, 859.5100792548242, 865.8657908024259, 899.6131663384746, 920.8848893888264, 15924.68150636988, 16673.749893751574, 16773.580660483465, 16800.0, 16914.154292285384, 16261.837381626181, 16761.0, 16849.32602695891, 16865.915670421662, 16917.83082169178, 721.7329588052428, 729.2379463460696, 840.1472505407016, 854.1543871567135, 857.6826574167567, 827.6275675945849, 827.9917200828005, 834.8288600836844, 846.0777752250046, 854.8760429737684, 877.398981697536, 887.6227603268617, 888.3071204460531, 888.5868071346822, 889.2485849457231, 750.2385079144673, 760.7945854619277, 879.3580686099151, 879.612970293069, 879.8768172455862, 622.0420552349376, 631.5579094633729, 637.971291291893, 643.1992169748646, 643.8841008618447, 16766.413175538797, 16876.071816050113, 16924.746128808078, 16930.153492325335, 16954.491365259062, 14503.274836258144, 14698.191599462025, 15216.315265812955, 15280.235988200546, 15343.769843452357, 13941.372638231303, 14174.787378189336, 14243.216623085726, 14284.0, 14352.56942291733, 4481.170983368087, 4592.839250626212, 4593.104344652794, 4599.655025873039, 4725.8582242532775, 76920.84618730667, 77755.0, 77857.0, 79885.0, 80960.59519702363, 12350.691232719253, 12369.381530923418, 12445.191062580903, 12500.374981250901, 12517.123801334, 24246.15138470145, 24410.023599056192, 24489.63265551018, 24736.628950565755, 24924.750752492244, 8347.457415268109, 8361.0, 8496.830063398698, 8519.659213631508, 8664.826703465895, 4531.161735079021, 4661.603763680125, 4680.063987202573, 4896.706197628154, 5067.1639179535705, 3951.9012024699036, 4042.4946881639794, 4065.0447144920918, 4066.959330406717, 4069.4709687740406, 663.2604645819972, 664.0504079166838, 666.2171947961126, 681.6080753566719, 684.852756657321, 694.3854688600625, 720.2797202797203, 724.4168444402306, 733.336330620789, 738.2211766586196, 10802.459877006118, 11577.710557235969, 11630.0, 12047.216930899463, 12205.572804951784, 818.0061225610912, 820.9835803283901, 821.8479581277483, 825.4593241426875, 828.2090603473669, 5350.250964864922, 5436.972815135899, 5480.369757477862, 5515.586331025189, 5557.888842223133, 63954.0, 64986.67506662436, 67655.0, 78812.60593696995, 82541.0, 58572.0, 65607.67196163989, 67955.98066029014, 68119.0, 69019.65490172617, 60000.09999850006, 60278.69860650669, 60486.69756651277, 60621.69689151614, 60680.0, 10669.733256668645, 11071.1696622752, 11157.66527004191, 11264.09887209005, 11330.546778128783, 40182.79908600439, 40614.0, 40940.0, 41389.58610413857, 42820.0, 50713.0, 52414.0, 53862.0, 53885.0, 54651.45348546463, 12792.488300467878, 13109.410076546388, 13506.527271545448, 13647.931760341531, 13723.931380343034, 16055.919720401324, 16100.114493702958, 16162.868599198413, 16414.589635259214, 17272.309107635552, 14254.714905702036, 14259.928700356431, 14273.14361138335, 14920.328585213474, 14920.552383428514, 13384.330783460593, 13426.261555614145, 13979.650508737363, 14236.572902812932, 14541.200233987232, 14378.640533986734, 14872.85127148758, 14966.625834354229, 15636.4527241546, 15650.060996340257, 11815.113866460222, 11846.940765296118, 12155.270683759003, 12357.063814090656, 12756.170848894792, 10640.787184256425, 11135.387553684624, 11642.0, 11790.351530665896, 11930.582429614922], "value": 7700.321203831589, "unit": "score"}], "name": "dromaeo_css", "value": 7510.827930109054, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 112.0, 112.0, 113.0, 110.0, 112.0, 111.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 115.0, 154.0, 122.0, 124.0, 123.0, 116.0, 137.0, 118.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 162.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 108.0, 75.0, 76.0, 75.0, 79.0, 101.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 102.0, 83.0, 82.0, 83.0, 97.0, 83.0, 82.0, 109.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 49.0, 49.0, 49.0, 49.0, 50.0, 48.0, 49.0, 48.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 76.0, 76.0, 79.0, 76.0, 75.0, 75.0, 75.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 130.0, 124.0, 120.0, 118.0, 130.0, 134.0, 153.0, 126.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 155.0, 158.0, 157.0, 159.0, 159.0, 161.0, 159.0, 160.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 60.0, 61.0, 58.0, 66.0, 60.0, 61.0, 58.0], "value": 60.7, "unit": "score"}], "name": "kraken", "value": 1465.1999999999998, "alertThreshold": 2.0}]} 04:51:19 INFO - Return code: 0 04:51:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:19 ERROR - # TBPL SUCCESS # 04:51:19 INFO - Running post-action listener: _resource_record_post_action 04:51:19 INFO - [mozharness: 2017-02-10 12:51:19.390188Z] Finished run-tests step (success) 04:51:19 INFO - Running post-run listener: _resource_record_post_run 04:51:19 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 255496192; Read time: 24; Write time: 164392 04:51:19 INFO - TinderboxPrint: CPU usage
13.0% 04:51:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 04:51:19 INFO - TinderboxPrint: I/O write bytes / time
255,496,192 / 164,392 04:51:19 INFO - TinderboxPrint: CPU idle
8,269.4 (87.0%) 04:51:19 INFO - TinderboxPrint: CPU user
1,193.9 (12.6%) 04:51:19 INFO - TinderboxPrint: Swap in / out
0 / 0 04:51:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 2555904; Read time: 0; Write time: 2144 04:51:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252145664; Read time: 24; Write time: 162248 04:51:20 INFO - Running post-run listener: _upload_blobber_files 04:51:20 INFO - Blob upload gear active. 04:51:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:20 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 04:51:20 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:20 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:21 INFO - (blobuploader) - INFO - Done attempting. 04:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:22 INFO - (blobuploader) - INFO - Done attempting. 04:51:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:25 INFO - (blobuploader) - INFO - Done attempting. 04:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:26 INFO - (blobuploader) - INFO - Done attempting. 04:51:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:26 INFO - Return code: 0 04:51:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1418c0fa297857202016e10baeb1ab14d0aa7cbb999a5407c1d2656ff712dc319fd22382c9366ec531a52fdf2abc0f9a6e5209d5365d02d3d991bcb9fbc9b4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbfd7da8505d33c87a1329bd7bbea9b20e04da0ae3511a908c5d237b73c1ba90bd9c873a6ac9c2e705cc7f9a0a023fe668710027b6f171391d6c24c3d538bf82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3c50a3873f1f73b94a953d761eebc6ae50ac4fef71980f2b2f0ec270c224027be52361efd22096b534ec841cb07d23ba907e251109a77bbce655894f6d4916c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcad9c65d299ed315b2518582a877a82e4cc884ddb0343d0cd5bccc36bcc902c7afcf18cd780a085542a4e948ace943bcbeb3f63b9d3e16f60d8c39e6ccbf3fb"} 04:51:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:26 INFO - Contents: 04:51:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1418c0fa297857202016e10baeb1ab14d0aa7cbb999a5407c1d2656ff712dc319fd22382c9366ec531a52fdf2abc0f9a6e5209d5365d02d3d991bcb9fbc9b4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbfd7da8505d33c87a1329bd7bbea9b20e04da0ae3511a908c5d237b73c1ba90bd9c873a6ac9c2e705cc7f9a0a023fe668710027b6f171391d6c24c3d538bf82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3c50a3873f1f73b94a953d761eebc6ae50ac4fef71980f2b2f0ec270c224027be52361efd22096b534ec841cb07d23ba907e251109a77bbce655894f6d4916c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcad9c65d299ed315b2518582a877a82e4cc884ddb0343d0cd5bccc36bcc902c7afcf18cd780a085542a4e948ace943bcbeb3f63b9d3e16f60d8c39e6ccbf3fb"} 04:51:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:26 INFO - Copying logs to upload dir... 04:51:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.292908 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-10 04:51:26.075009) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 04:51:26.078450) ========= 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=41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1418c0fa297857202016e10baeb1ab14d0aa7cbb999a5407c1d2656ff712dc319fd22382c9366ec531a52fdf2abc0f9a6e5209d5365d02d3d991bcb9fbc9b4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbfd7da8505d33c87a1329bd7bbea9b20e04da0ae3511a908c5d237b73c1ba90bd9c873a6ac9c2e705cc7f9a0a023fe668710027b6f171391d6c24c3d538bf82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3c50a3873f1f73b94a953d761eebc6ae50ac4fef71980f2b2f0ec270c224027be52361efd22096b534ec841cb07d23ba907e251109a77bbce655894f6d4916c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcad9c65d299ed315b2518582a877a82e4cc884ddb0343d0cd5bccc36bcc902c7afcf18cd780a085542a4e948ace943bcbeb3f63b9d3e16f60d8c39e6ccbf3fb"} build_url:https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/BnzgM0fwSH6W0AnJsDbKoA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1418c0fa297857202016e10baeb1ab14d0aa7cbb999a5407c1d2656ff712dc319fd22382c9366ec531a52fdf2abc0f9a6e5209d5365d02d3d991bcb9fbc9b4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fbfd7da8505d33c87a1329bd7bbea9b20e04da0ae3511a908c5d237b73c1ba90bd9c873a6ac9c2e705cc7f9a0a023fe668710027b6f171391d6c24c3d538bf82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3c50a3873f1f73b94a953d761eebc6ae50ac4fef71980f2b2f0ec270c224027be52361efd22096b534ec841cb07d23ba907e251109a77bbce655894f6d4916c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dcad9c65d299ed315b2518582a877a82e4cc884ddb0343d0cd5bccc36bcc902c7afcf18cd780a085542a4e948ace943bcbeb3f63b9d3e16f60d8c39e6ccbf3fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 04:51:26.106117) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:51:26.106418) ========= 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=41bf3e9aed84707956354da8000001c5-1486729735.301866-981750314 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 04:51:26.188936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 04:51:26.189270) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 04:51:26.189571) ========= ========= Total master_lag: 0.16 =========