builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1483542217.62 results: success (0) revision: c8b77ff3986597028c3ea39f42109289b8bf0e56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.618553) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.619038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.619314) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.637003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.637303) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-04 07:03:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.7M=0s 2017-01-04 07:03:39 (95.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125058 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.775767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.776076) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020520 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.828223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:37.831646) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c8b77ff3986597028c3ea39f42109289b8bf0e56 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev c8b77ff3986597028c3ea39f42109289b8bf0e56 --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=97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-04 07:03:39,420 truncating revision to first 12 chars 2017-01-04 07:03:39,420 Setting DEBUG logging. 2017-01-04 07:03:39,420 attempt 1/10 2017-01-04 07:03:39,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c8b77ff39865?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 07:03:39,756 unpacking tar archive at: mozilla-central-c8b77ff39865/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641771 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:38.486453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:38.486771) ========= script_repo_revision: c8b77ff3986597028c3ea39f42109289b8bf0e56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:38.487136) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:38.487402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 07:03:38.495818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-04 07:03:38.496089) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:03:40 INFO - MultiFileLogger online at 20170104 07:03:40 in /builds/slave/test 07:03:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:03:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:03:40 INFO - {'append_to_log': False, 07:03:40 INFO - 'base_work_dir': '/builds/slave/test', 07:03:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:03:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:03:40 INFO - 'branch': 'Firefox-Non-PGO', 07:03:40 INFO - 'buildbot_json_path': 'buildprops.json', 07:03:40 INFO - 'config_files': ('talos/linux_config.py',), 07:03:40 INFO - 'default_actions': ('clobber', 07:03:40 INFO - 'read-buildbot-config', 07:03:40 INFO - 'download-and-extract', 07:03:40 INFO - 'populate-webroot', 07:03:40 INFO - 'create-virtualenv', 07:03:40 INFO - 'install', 07:03:40 INFO - 'run-tests'), 07:03:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:03:40 INFO - 'download_minidump_stackwalk': True, 07:03:40 INFO - 'download_symbols': 'ondemand', 07:03:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:03:40 INFO - 'tooltool.py': '/tools/tooltool.py', 07:03:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:03:40 INFO - '/tools/misc-python/virtualenv.py')}, 07:03:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:03:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:03:40 INFO - 'installer_path': 'installer.exe', 07:03:40 INFO - 'log_level': 'info', 07:03:40 INFO - 'log_name': 'talos', 07:03:40 INFO - 'log_to_console': True, 07:03:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:03:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:03:40 INFO - 'opt_config_files': (), 07:03:40 INFO - 'pip_index': False, 07:03:40 INFO - 'sps_profile': False, 07:03:40 INFO - 'sps_profile_interval': 0, 07:03:40 INFO - 'suite': 'dromaeojs-e10s', 07:03:40 INFO - 'system_bits': '32', 07:03:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:03:40 INFO - 'title': 'talos-linux64-ix-068', 07:03:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:03:40 INFO - 'use_talos_json': True, 07:03:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:03:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:03:40 INFO - 'work_dir': 'build'} 07:03:40 INFO - [mozharness: 2017-01-04 15:03:40.181012Z] Running clobber step. 07:03:40 INFO - Running pre-action listener: _resource_record_pre_action 07:03:40 INFO - Running main action method: clobber 07:03:40 INFO - rmtree: /builds/slave/test/build 07:03:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:03:41 INFO - Running post-action listener: _resource_record_post_action 07:03:41 INFO - [mozharness: 2017-01-04 15:03:41.156420Z] Finished clobber step (success) 07:03:41 INFO - [mozharness: 2017-01-04 15:03:41.156520Z] Running read-buildbot-config step. 07:03:41 INFO - Running pre-action listener: _resource_record_pre_action 07:03:41 INFO - Running main action method: read_buildbot_config 07:03:41 INFO - Using buildbot properties: 07:03:41 INFO - { 07:03:41 INFO - "project": "", 07:03:41 INFO - "product": "firefox", 07:03:41 INFO - "who": "ffxbld@noreply.mozilla.org", 07:03:41 INFO - "installer_path": "public/build/target.tar.bz2", 07:03:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:03:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:03:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:03:41 INFO - "stage_platform": "linux64", 07:03:41 INFO - "basedir": "/builds/slave/test", 07:03:41 INFO - "buildnumber": 626, 07:03:41 INFO - "platform": "ubuntu64_hw", 07:03:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:03:41 INFO - "slavebuilddir": "test", 07:03:41 INFO - "taskId": "N1lfiiNDS_CQqsPA2_GqDQ", 07:03:41 INFO - "branch": "mozilla-central", 07:03:41 INFO - "script_repo_revision": "production", 07:03:41 INFO - "revision": "c8b77ff3986597028c3ea39f42109289b8bf0e56", 07:03:41 INFO - "slavename": "talos-linux64-ix-068", 07:03:41 INFO - "repo_path": "mozilla-central" 07:03:41 INFO - } 07:03:41 INFO - Finding installer, test and symbols from parent task. 07:03:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1lfiiNDS_CQqsPA2_GqDQ'}, attempt #1 07:03:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1lfiiNDS_CQqsPA2_GqDQ'}, attempt #1 07:03:42 INFO - Task dependencies: SgwOvsZVSeuLniXBIdkpwQ 07:03:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ'}, attempt #1 07:03:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 07:03:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/test_packages.json 07:03:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.crashreporter-symbols.zip 07:03:42 INFO - Running post-action listener: _resource_record_post_action 07:03:42 INFO - [mozharness: 2017-01-04 15:03:42.580335Z] Finished read-buildbot-config step (success) 07:03:42 INFO - [mozharness: 2017-01-04 15:03:42.580553Z] Running download-and-extract step. 07:03:42 INFO - Running pre-action listener: _resource_record_pre_action 07:03:42 INFO - Running main action method: download_and_extract 07:03:42 INFO - mkdir: /builds/slave/test/build/tests 07:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:42 INFO - trying https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.test_packages.json 07:03:42 INFO - Downloading https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:03:43 INFO - Downloaded 896 bytes. 07:03:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:03:43 INFO - Using the following test package requirements: 07:03:43 INFO - {u'common': [u'target.common.tests.zip'], 07:03:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:03:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:03:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:03:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:03:43 INFO - u'mozbase': [u'target.common.tests.zip'], 07:03:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:03:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:03:43 INFO - u'web-platform': [u'target.common.tests.zip', 07:03:43 INFO - u'target.web-platform.tests.zip'], 07:03:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:03:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:03:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip 07:03:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:03:43 INFO - Fetch https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip into memory 07:03:43 INFO - Expected file size: 20247084 07:03:43 INFO - Obtained file size: 20247084 07:03:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:03:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip 07:03:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:03:48 INFO - Fetch https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.common.tests.zip into memory 07:03:48 INFO - Expected file size: 20247084 07:03:48 INFO - Obtained file size: 20247084 07:03:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.talos.tests.zip 07:03:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:03:53 INFO - Fetch https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.talos.tests.zip into memory 07:03:54 INFO - Expected file size: 14403730 07:03:54 INFO - Obtained file size: 14403730 07:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:03:54 INFO - trying https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 07:03:54 INFO - Downloading https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:03:55 INFO - Downloaded 55917614 bytes. 07:03:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 07:03:55 INFO - mkdir: /builds/slave/test/properties 07:03:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:03:55 INFO - Writing to file /builds/slave/test/properties/build_url 07:03:55 INFO - Contents: 07:03:55 INFO - build_url:https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 07:03:55 INFO - Running post-action listener: _resource_record_post_action 07:03:55 INFO - Running post-action listener: set_extra_try_arguments 07:03:55 INFO - [mozharness: 2017-01-04 15:03:55.416739Z] Finished download-and-extract step (success) 07:03:55 INFO - [mozharness: 2017-01-04 15:03:55.416836Z] Running populate-webroot step. 07:03:55 INFO - Running pre-action listener: _resource_record_pre_action 07:03:55 INFO - Running main action method: populate_webroot 07:03:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:03:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:03:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:03:55 INFO - '--tppagecycles', 07:03:55 INFO - '7'], 07:03:55 INFO - 'tests': ['tsvgm']}}, 07:03:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:03:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:03:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:03:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:03:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:03:55 INFO - 'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:03:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:03:55 INFO - 'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['damp', 'tps']}, 07:03:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:03:55 INFO - 'tests': ['damp', 'tps']}, 07:03:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['dromaeo_dom']}, 07:03:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:03:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['basic_compositor_video']}, 07:03:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:03:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['a11yr', 07:03:55 INFO - 'ts_paint', 07:03:55 INFO - 'tpaint', 07:03:55 INFO - 'sessionrestore', 07:03:55 INFO - 'sessionrestore_no_auto_restore', 07:03:55 INFO - 'tabpaint']}, 07:03:55 INFO - 'other-e10s': {'tests': ['a11yr', 07:03:55 INFO - 'ts_paint', 07:03:55 INFO - 'tpaint', 07:03:55 INFO - 'sessionrestore', 07:03:55 INFO - 'sessionrestore_no_auto_restore', 07:03:55 INFO - 'tabpaint']}, 07:03:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:03:55 INFO - 'ts_paint', 07:03:55 INFO - 'tpaint', 07:03:55 INFO - 'sessionrestore', 07:03:55 INFO - 'sessionrestore_no_auto_restore', 07:03:55 INFO - 'tabpaint']}, 07:03:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:03:55 INFO - 'ts_paint', 07:03:55 INFO - 'tpaint', 07:03:55 INFO - 'sessionrestore', 07:03:55 INFO - 'sessionrestore_no_auto_restore', 07:03:55 INFO - 'tabpaint']}, 07:03:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['a11yr', 07:03:55 INFO - 'ts_paint', 07:03:55 INFO - 'tpaint', 07:03:55 INFO - 'sessionrestore', 07:03:55 INFO - 'sessionrestore_no_auto_restore', 07:03:55 INFO - 'tabpaint']}, 07:03:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['a11yr', 07:03:55 INFO - 'ts_paint', 07:03:55 INFO - 'tpaint', 07:03:55 INFO - 'sessionrestore', 07:03:55 INFO - 'sessionrestore_no_auto_restore', 07:03:55 INFO - 'tabpaint']}, 07:03:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['tsvgx', 07:03:55 INFO - 'tsvgr_opacity', 07:03:55 INFO - 'tart', 07:03:55 INFO - 'tscrollx', 07:03:55 INFO - 'cart', 07:03:55 INFO - 'tsvg_static']}, 07:03:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:03:55 INFO - 'tsvgr_opacity', 07:03:55 INFO - 'tart', 07:03:55 INFO - 'tscrollx', 07:03:55 INFO - 'cart', 07:03:55 INFO - 'tsvg_static']}, 07:03:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:03:55 INFO - 'talos_options': ['--disable-e10s'], 07:03:55 INFO - 'tests': ['tp5o']}, 07:03:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:03:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:03:55 INFO - 'talos_options': ['--disable-e10s', 07:03:55 INFO - '--xperf_path', 07:03:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:55 INFO - 'tests': ['tp5n']}, 07:03:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:03:55 INFO - 'talos_options': ['--xperf_path', 07:03:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:55 INFO - 'tests': ['tp5n']}}, 07:03:55 INFO - 'talos.zip': {'path': '', 07:03:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:03:55 INFO - Running post-action listener: _resource_record_post_action 07:03:55 INFO - [mozharness: 2017-01-04 15:03:55.429950Z] Finished populate-webroot step (success) 07:03:55 INFO - [mozharness: 2017-01-04 15:03:55.430039Z] Running create-virtualenv step. 07:03:55 INFO - Running pre-action listener: _resource_record_pre_action 07:03:55 INFO - Running main action method: create_virtualenv 07:03:55 INFO - Creating virtualenv /builds/slave/test/build/venv 07:03:55 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 07:03:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:03:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:03:55 INFO - Using real prefix '/usr' 07:03:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:03:56 INFO - Installing distribute.............................................................................................................................................................................................done. 07:03:57 INFO - Installing pip.................done. 07:03:58 INFO - Return code: 0 07:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:03:58 INFO - Reading from file tmpfile_stdout 07:03:58 INFO - Output received: 07:03:58 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) 07:03:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:03: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')]} 07:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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')]} 07:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:58 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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:03:58 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 07:03:58 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 07:03:58 INFO - Using env: {'DISPLAY': ':0', 07:03:58 INFO - 'HOME': '/home/cltbld', 07:03:58 INFO - 'LANG': 'en_US.UTF-8', 07:03:58 INFO - 'LANGUAGE': 'en_US:en', 07:03:58 INFO - 'LOGNAME': 'cltbld', 07:03:58 INFO - 'MAIL': '/var/mail/cltbld', 07:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:58 INFO - 'MOZ_NO_REMOTE': '1', 07:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:58 INFO - 'NO_EM_RESTART': '1', 07:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:58 INFO - 'PWD': '/builds/slave/test', 07:03:58 INFO - 'SHELL': '/bin/bash', 07:03:58 INFO - 'SHLVL': '1', 07:03:58 INFO - 'TERM': 'linux', 07:03:58 INFO - 'TMOUT': '86400', 07:03:58 INFO - 'USER': 'cltbld', 07:03:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:58 INFO - '_': '/tools/buildbot/bin/python'} 07:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:58 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 07:03:58 INFO - Cleaning up... 07:03:58 INFO - Return code: 0 07:03:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:03: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')]} 07:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03: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')]} 07:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:58 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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:03:58 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 07:03:58 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 07:03:58 INFO - Using env: {'DISPLAY': ':0', 07:03:58 INFO - 'HOME': '/home/cltbld', 07:03:58 INFO - 'LANG': 'en_US.UTF-8', 07:03:58 INFO - 'LANGUAGE': 'en_US:en', 07:03:58 INFO - 'LOGNAME': 'cltbld', 07:03:58 INFO - 'MAIL': '/var/mail/cltbld', 07:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:58 INFO - 'MOZ_NO_REMOTE': '1', 07:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:58 INFO - 'NO_EM_RESTART': '1', 07:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:58 INFO - 'PWD': '/builds/slave/test', 07:03:58 INFO - 'SHELL': '/bin/bash', 07:03:58 INFO - 'SHLVL': '1', 07:03:58 INFO - 'TERM': 'linux', 07:03:58 INFO - 'TMOUT': '86400', 07:03:58 INFO - 'USER': 'cltbld', 07:03:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:58 INFO - '_': '/tools/buildbot/bin/python'} 07:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:58 INFO - Downloading/unpacking psutil>=3.1.1 07:03:58 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 07:03:58 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 07:03:58 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 07:03:58 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 07:03:58 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 07:03:58 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 07:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:04:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:00 INFO - Installing collected packages: psutil 07:04:00 INFO - Running setup.py install for psutil 07:04:00 INFO - building 'psutil._psutil_linux' extension 07:04:00 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 07:04:01 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 07:04:01 INFO - building 'psutil._psutil_posix' extension 07:04:01 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 07:04:01 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 07:04:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:04:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:04:01 INFO - Successfully installed psutil 07:04:01 INFO - Cleaning up... 07:04:01 INFO - Return code: 0 07:04:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:04:01 INFO - Using env: {'DISPLAY': ':0', 07:04:01 INFO - 'HOME': '/home/cltbld', 07:04:01 INFO - 'LANG': 'en_US.UTF-8', 07:04:01 INFO - 'LANGUAGE': 'en_US:en', 07:04:01 INFO - 'LOGNAME': 'cltbld', 07:04:01 INFO - 'MAIL': '/var/mail/cltbld', 07:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:01 INFO - 'MOZ_NO_REMOTE': '1', 07:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:01 INFO - 'NO_EM_RESTART': '1', 07:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:01 INFO - 'PWD': '/builds/slave/test', 07:04:01 INFO - 'SHELL': '/bin/bash', 07:04:01 INFO - 'SHLVL': '1', 07:04:01 INFO - 'TERM': 'linux', 07:04:01 INFO - 'TMOUT': '86400', 07:04:01 INFO - 'USER': 'cltbld', 07:04:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:01 INFO - '_': '/tools/buildbot/bin/python'} 07:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:04:03 INFO - Installing collected packages: mozsystemmonitor 07:04:03 INFO - Running setup.py install for mozsystemmonitor 07:04:03 INFO - Successfully installed mozsystemmonitor 07:04:03 INFO - Cleaning up... 07:04:03 INFO - Return code: 0 07:04:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:04:03 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')]} 07:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:03 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')]} 07:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:03 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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:04:03 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 07:04:03 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 07:04:03 INFO - Using env: {'DISPLAY': ':0', 07:04:03 INFO - 'HOME': '/home/cltbld', 07:04:03 INFO - 'LANG': 'en_US.UTF-8', 07:04:03 INFO - 'LANGUAGE': 'en_US:en', 07:04:03 INFO - 'LOGNAME': 'cltbld', 07:04:03 INFO - 'MAIL': '/var/mail/cltbld', 07:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:03 INFO - 'MOZ_NO_REMOTE': '1', 07:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:03 INFO - 'NO_EM_RESTART': '1', 07:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:03 INFO - 'PWD': '/builds/slave/test', 07:04:03 INFO - 'SHELL': '/bin/bash', 07:04:03 INFO - 'SHLVL': '1', 07:04:03 INFO - 'TERM': 'linux', 07:04:03 INFO - 'TMOUT': '86400', 07:04:03 INFO - 'USER': 'cltbld', 07:04:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:03 INFO - '_': '/tools/buildbot/bin/python'} 07:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:03 INFO - Downloading/unpacking jsonschema==2.5.1 07:04:03 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 07:04:03 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 07:04:03 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 07:04:03 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 07:04:03 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 07:04:03 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 07:04:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:04:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:04:05 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 07:04:05 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 07:04:05 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 07:04:05 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 07:04:05 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 07:04:05 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 07:04:06 INFO - Downloading functools32-3.2.3-2.tar.gz 07:04:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:04:06 INFO - warning: no files found matching '*.txt' 07:04:06 INFO - no previously-included directories found matching 'build' 07:04:06 INFO - no previously-included directories found matching 'dist' 07:04:06 INFO - no previously-included directories found matching '.git*' 07:04:06 INFO - Installing collected packages: jsonschema, functools32 07:04:06 INFO - Running setup.py install for functools32 07:04:06 INFO - warning: no files found matching '*.txt' 07:04:06 INFO - no previously-included directories found matching 'build' 07:04:06 INFO - no previously-included directories found matching 'dist' 07:04:06 INFO - no previously-included directories found matching '.git*' 07:04:06 INFO - Successfully installed jsonschema functools32 07:04:06 INFO - Cleaning up... 07:04:06 INFO - Return code: 0 07:04:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:04: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 07:04: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 07:04:06 INFO - Using env: {'DISPLAY': ':0', 07:04:06 INFO - 'HOME': '/home/cltbld', 07:04:06 INFO - 'LANG': 'en_US.UTF-8', 07:04:06 INFO - 'LANGUAGE': 'en_US:en', 07:04:06 INFO - 'LOGNAME': 'cltbld', 07:04:06 INFO - 'MAIL': '/var/mail/cltbld', 07:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:06 INFO - 'MOZ_NO_REMOTE': '1', 07:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:06 INFO - 'NO_EM_RESTART': '1', 07:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:06 INFO - 'PWD': '/builds/slave/test', 07:04:06 INFO - 'SHELL': '/bin/bash', 07:04:06 INFO - 'SHLVL': '1', 07:04:06 INFO - 'TERM': 'linux', 07:04:06 INFO - 'TMOUT': '86400', 07:04:06 INFO - 'USER': 'cltbld', 07:04:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:06 INFO - '_': '/tools/buildbot/bin/python'} 07:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:04:06 INFO - Cleaning up... 07:04:06 INFO - Return code: 0 07:04:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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', '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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:04: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:04: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 blobuploader==1.2.4 07:04:06 INFO - Using env: {'DISPLAY': ':0', 07:04:06 INFO - 'HOME': '/home/cltbld', 07:04:06 INFO - 'LANG': 'en_US.UTF-8', 07:04:06 INFO - 'LANGUAGE': 'en_US:en', 07:04:06 INFO - 'LOGNAME': 'cltbld', 07:04:06 INFO - 'MAIL': '/var/mail/cltbld', 07:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:06 INFO - 'MOZ_NO_REMOTE': '1', 07:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:06 INFO - 'NO_EM_RESTART': '1', 07:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:06 INFO - 'PWD': '/builds/slave/test', 07:04:06 INFO - 'SHELL': '/bin/bash', 07:04:06 INFO - 'SHLVL': '1', 07:04:06 INFO - 'TERM': 'linux', 07:04:06 INFO - 'TMOUT': '86400', 07:04:06 INFO - 'USER': 'cltbld', 07:04:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:06 INFO - '_': '/tools/buildbot/bin/python'} 07:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:04:06 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 07:04:06 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 07:04:06 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 07:04:06 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 07:04:06 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 07:04:06 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 07:04:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:04:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:04:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:04:09 INFO - Downloading docopt-0.6.1.tar.gz 07:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:04:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:04:09 INFO - Running setup.py install for blobuploader 07:04:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:04:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:04:09 INFO - Running setup.py install for requests 07:04:10 INFO - Running setup.py install for docopt 07:04:10 INFO - Successfully installed blobuploader requests docopt 07:04:10 INFO - Cleaning up... 07:04:10 INFO - Return code: 0 07:04:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:10 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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:04:10 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 07:04:10 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 07:04:10 INFO - Using env: {'DISPLAY': ':0', 07:04:10 INFO - 'HOME': '/home/cltbld', 07:04:10 INFO - 'LANG': 'en_US.UTF-8', 07:04:10 INFO - 'LANGUAGE': 'en_US:en', 07:04:10 INFO - 'LOGNAME': 'cltbld', 07:04:10 INFO - 'MAIL': '/var/mail/cltbld', 07:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:10 INFO - 'MOZ_NO_REMOTE': '1', 07:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:10 INFO - 'NO_EM_RESTART': '1', 07:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:10 INFO - 'PWD': '/builds/slave/test', 07:04:10 INFO - 'SHELL': '/bin/bash', 07:04:10 INFO - 'SHLVL': '1', 07:04:10 INFO - 'TERM': 'linux', 07:04:10 INFO - 'TMOUT': '86400', 07:04:10 INFO - 'USER': 'cltbld', 07:04:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:10 INFO - '_': '/tools/buildbot/bin/python'} 07:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:10 INFO - Running setup.py (path:/tmp/pip-ghYwY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:10 INFO - Running setup.py (path:/tmp/pip-CCJ8PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:10 INFO - Running setup.py (path:/tmp/pip-5fOYyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:10 INFO - Running setup.py (path:/tmp/pip-hxRW8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:10 INFO - Running setup.py (path:/tmp/pip-IXpDRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:10 INFO - Running setup.py (path:/tmp/pip-zUmPmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:10 INFO - Running setup.py (path:/tmp/pip-DZlJ6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:11 INFO - Running setup.py (path:/tmp/pip-1fEp_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:11 INFO - Running setup.py (path:/tmp/pip-1K2gsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:11 INFO - Running setup.py (path:/tmp/pip-EkTLXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:11 INFO - Running setup.py (path:/tmp/pip-gNJjtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:11 INFO - Running setup.py (path:/tmp/pip-YOTa0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:11 INFO - Running setup.py (path:/tmp/pip-S9xemY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:11 INFO - Running setup.py (path:/tmp/pip-3sggga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:11 INFO - Running setup.py (path:/tmp/pip-ydvUZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:11 INFO - Running setup.py (path:/tmp/pip-X0UA_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:11 INFO - Running setup.py (path:/tmp/pip-SyNYxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:04:11 INFO - Running setup.py install for manifestparser 07:04:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:04:11 INFO - Running setup.py install for mozcrash 07:04:11 INFO - Running setup.py install for mozdebug 07:04:12 INFO - Running setup.py install for mozdevice 07:04:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozfile 07:04:12 INFO - Running setup.py install for mozhttpd 07:04:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozinfo 07:04:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozInstall 07:04:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozleak 07:04:12 INFO - Running setup.py install for mozlog 07:04:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for moznetwork 07:04:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:04:12 INFO - Running setup.py install for mozprocess 07:04:13 INFO - Running setup.py install for mozprofile 07:04:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozrunner 07:04:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Running setup.py install for mozscreenshot 07:04:13 INFO - Running setup.py install for moztest 07:04:13 INFO - Running setup.py install for mozversion 07:04:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:04:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:04:13 INFO - Cleaning up... 07:04:13 INFO - Return code: 0 07:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:13 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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:04:13 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 07:04:13 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 07:04:13 INFO - Using env: {'DISPLAY': ':0', 07:04:13 INFO - 'HOME': '/home/cltbld', 07:04:13 INFO - 'LANG': 'en_US.UTF-8', 07:04:13 INFO - 'LANGUAGE': 'en_US:en', 07:04:13 INFO - 'LOGNAME': 'cltbld', 07:04:13 INFO - 'MAIL': '/var/mail/cltbld', 07:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:13 INFO - 'MOZ_NO_REMOTE': '1', 07:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:13 INFO - 'NO_EM_RESTART': '1', 07:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:13 INFO - 'PWD': '/builds/slave/test', 07:04:13 INFO - 'SHELL': '/bin/bash', 07:04:13 INFO - 'SHLVL': '1', 07:04:13 INFO - 'TERM': 'linux', 07:04:13 INFO - 'TMOUT': '86400', 07:04:13 INFO - 'USER': 'cltbld', 07:04:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:13 INFO - '_': '/tools/buildbot/bin/python'} 07:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:04:13 INFO - Running setup.py (path:/tmp/pip-1BXaVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:04:13 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)) 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:04:13 INFO - Running setup.py (path:/tmp/pip-QSyOOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:04:13 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)) 07:04:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:04:13 INFO - Running setup.py (path:/tmp/pip-9nRiZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:04:14 INFO - Running setup.py (path:/tmp/pip-mXPKyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:04:14 INFO - Running setup.py (path:/tmp/pip-xK9IVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:04:14 INFO - Running setup.py (path:/tmp/pip-V1e0xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:04:14 INFO - Running setup.py (path:/tmp/pip-VQn9qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:04:14 INFO - Running setup.py (path:/tmp/pip-FbIUTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:04:14 INFO - Running setup.py (path:/tmp/pip-lrRIx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:04:14 INFO - Running setup.py (path:/tmp/pip-iWsK3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:04:14 INFO - Running setup.py (path:/tmp/pip-h74ddi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:04:14 INFO - Running setup.py (path:/tmp/pip-TntZWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:04:14 INFO - Running setup.py (path:/tmp/pip-2C0kOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:04:14 INFO - Running setup.py (path:/tmp/pip-S8F7qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:14 INFO - Running setup.py (path:/tmp/pip-0bgFxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:04:14 INFO - Running setup.py (path:/tmp/pip-658N78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:04:14 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)) 07:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:04:15 INFO - Running setup.py (path:/tmp/pip-XFPMGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:04:15 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)) 07:04:15 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)) 07:04:15 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)) 07:04:15 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)) 07:04:15 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)) 07:04:15 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)) 07:04:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:04:15 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 07:04:15 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 07:04:15 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 07:04:15 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 07:04:15 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 07:04:15 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 07:04:17 INFO - Downloading blessings-1.6.tar.gz 07:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:04:17 INFO - Installing collected packages: blessings 07:04:17 INFO - Running setup.py install for blessings 07:04:17 INFO - Successfully installed blessings 07:04:17 INFO - Cleaning up... 07:04:17 INFO - Return code: 0 07:04:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:04:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:17 INFO - Reading from file tmpfile_stdout 07:04:17 INFO - Current package versions: 07:04:17 INFO - argparse == 1.2.1 07:04:17 INFO - blessings == 1.6 07:04:17 INFO - blobuploader == 1.2.4 07:04:17 INFO - docopt == 0.6.1 07:04:17 INFO - functools32 == 3.2.3-2 07:04:17 INFO - jsonschema == 2.5.1 07:04:17 INFO - manifestparser == 1.1 07:04:17 INFO - mozInstall == 1.12 07:04:17 INFO - mozcrash == 1.0 07:04:17 INFO - mozdebug == 0.1 07:04:17 INFO - mozdevice == 0.49 07:04:17 INFO - mozfile == 1.2 07:04:17 INFO - mozhttpd == 0.7 07:04:17 INFO - mozinfo == 0.9 07:04:17 INFO - mozleak == 0.1 07:04:17 INFO - mozlog == 3.4 07:04:17 INFO - moznetwork == 0.27 07:04:17 INFO - mozprocess == 0.23 07:04:17 INFO - mozprofile == 0.28 07:04:17 INFO - mozrunner == 6.13 07:04:17 INFO - mozscreenshot == 0.1 07:04:17 INFO - mozsystemmonitor == 0.3 07:04:17 INFO - moztest == 0.8 07:04:17 INFO - mozversion == 1.4 07:04:17 INFO - psutil == 3.1.1 07:04:17 INFO - requests == 1.2.3 07:04:17 INFO - wsgiref == 0.1.2 07:04:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:17 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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:04:17 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 07:04:17 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 07:04:17 INFO - Using env: {'DISPLAY': ':0', 07:04:17 INFO - 'HOME': '/home/cltbld', 07:04:17 INFO - 'LANG': 'en_US.UTF-8', 07:04:17 INFO - 'LANGUAGE': 'en_US:en', 07:04:17 INFO - 'LOGNAME': 'cltbld', 07:04:17 INFO - 'MAIL': '/var/mail/cltbld', 07:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:17 INFO - 'MOZ_NO_REMOTE': '1', 07:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:17 INFO - 'NO_EM_RESTART': '1', 07:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:17 INFO - 'PWD': '/builds/slave/test', 07:04:17 INFO - 'SHELL': '/bin/bash', 07:04:17 INFO - 'SHLVL': '1', 07:04:17 INFO - 'TERM': 'linux', 07:04:17 INFO - 'TMOUT': '86400', 07:04:17 INFO - 'USER': 'cltbld', 07:04:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:17 INFO - '_': '/tools/buildbot/bin/python'} 07:04:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 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)) 07:04:17 INFO - Cleaning up... 07:04:17 INFO - Return code: 0 07:04:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:04: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')]} 07:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04: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')]} 07:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:04:17 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 0x19c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d36480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', '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 07:04:17 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 07:04:17 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 07:04:17 INFO - Using env: {'DISPLAY': ':0', 07:04:17 INFO - 'HOME': '/home/cltbld', 07:04:17 INFO - 'LANG': 'en_US.UTF-8', 07:04:17 INFO - 'LANGUAGE': 'en_US:en', 07:04:17 INFO - 'LOGNAME': 'cltbld', 07:04:17 INFO - 'MAIL': '/var/mail/cltbld', 07:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:17 INFO - 'MOZ_NO_REMOTE': '1', 07:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:17 INFO - 'NO_EM_RESTART': '1', 07:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:17 INFO - 'PWD': '/builds/slave/test', 07:04:17 INFO - 'SHELL': '/bin/bash', 07:04:17 INFO - 'SHLVL': '1', 07:04:17 INFO - 'TERM': 'linux', 07:04:17 INFO - 'TMOUT': '86400', 07:04:17 INFO - 'USER': 'cltbld', 07:04:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:17 INFO - '_': '/tools/buildbot/bin/python'} 07:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:04:18 INFO - Cleaning up... 07:04:18 INFO - Return code: 0 07:04:18 INFO - Running post-action listener: _resource_record_post_action 07:04:18 INFO - Running post-action listener: _start_resource_monitoring 07:04:18 INFO - Starting resource monitoring. 07:04:18 INFO - [mozharness: 2017-01-04 15:04:18.066615Z] Finished create-virtualenv step (success) 07:04:18 INFO - [mozharness: 2017-01-04 15:04:18.067075Z] Running install step. 07:04:18 INFO - Running pre-action listener: _resource_record_pre_action 07:04:18 INFO - Running main action method: install 07:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:04:18 INFO - Reading from file tmpfile_stdout 07:04:18 INFO - Detecting whether we're running mozinstall >=1.0... 07:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:04:18 INFO - Reading from file tmpfile_stdout 07:04:18 INFO - Output received: 07:04:18 INFO - Usage: mozinstall [options] installer 07:04:18 INFO - Options: 07:04:18 INFO - -h, --help show this help message and exit 07:04:18 INFO - -d DEST, --destination=DEST 07:04:18 INFO - Directory to install application into. [default: 07:04:18 INFO - "/builds/slave/test"] 07:04:18 INFO - --app=APP Application being installed. [default: firefox] 07:04:18 INFO - mkdir: /builds/slave/test/build/application 07:04:18 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'] 07:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:04:34 INFO - Reading from file tmpfile_stdout 07:04:34 INFO - Output received: 07:04:34 INFO - /builds/slave/test/build/application/firefox/firefox 07:04:34 INFO - Running post-action listener: _resource_record_post_action 07:04:34 INFO - [mozharness: 2017-01-04 15:04:34.537272Z] Finished install step (success) 07:04:34 INFO - [mozharness: 2017-01-04 15:04:34.537548Z] Running run-tests step. 07:04:34 INFO - Running pre-action listener: _resource_record_pre_action 07:04:34 INFO - Running main action method: run_tests 07:04:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:04:34 INFO - Python 2.7.3 07:04:34 INFO - Return code: 0 07:04:34 INFO - grabbing minidump binary from tooltool 07:04:34 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')]} 07:04:34 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 0x1d33820>, '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 0x1d34520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d349b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:04:34 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 07:04:34 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 07:04:34 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 07:04:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:04:34 INFO - Return code: 0 07:04:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:04:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:04:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:04:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:04:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:04:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:04:34 INFO - Using env: {'DISPLAY': ':0', 07:04:34 INFO - 'HOME': '/home/cltbld', 07:04:34 INFO - 'LANG': 'en_US.UTF-8', 07:04:34 INFO - 'LANGUAGE': 'en_US:en', 07:04:34 INFO - 'LOGNAME': 'cltbld', 07:04:34 INFO - 'MAIL': '/var/mail/cltbld', 07:04:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:34 INFO - 'MOZ_NO_REMOTE': '1', 07:04:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:34 INFO - 'NO_EM_RESTART': '1', 07:04:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:34 INFO - 'PWD': '/builds/slave/test', 07:04:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:34 INFO - 'SHELL': '/bin/bash', 07:04:34 INFO - 'SHLVL': '1', 07:04:34 INFO - 'TERM': 'linux', 07:04:34 INFO - 'TMOUT': '86400', 07:04:34 INFO - 'USER': 'cltbld', 07:04:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420', 07:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:34 INFO - '_': '/tools/buildbot/bin/python'} 07:04:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:04:34 INFO - mozversion application_buildid: 20170104143437 07:04:34 INFO - mozversion application_changeset: c8b77ff3986597028c3ea39f42109289b8bf0e56 07:04:34 INFO - mozversion application_display_name: Nightly 07:04:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:04:34 INFO - mozversion application_name: Firefox 07:04:34 INFO - mozversion application_remotingname: firefox 07:04:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:04:34 INFO - mozversion application_vendor: Mozilla 07:04:34 INFO - mozversion application_version: 53.0a1 07:04:34 INFO - mozversion platform_buildid: 20170104143437 07:04:34 INFO - mozversion platform_changeset: c8b77ff3986597028c3ea39f42109289b8bf0e56 07:04:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:04:34 INFO - mozversion platform_version: 53.0a1 07:04:34 INFO - using testdate: 1483542274 07:04:34 INFO - actual date: 1483542274 07:04:34 INFO - starting webserver on 'localhost:55279' 07:04:34 INFO - SUITE-START | Running 2 tests 07:04:34 INFO - TEST-START | dromaeo_css 07:04:34 INFO - operating with platform_type : linux_ 07:04:34 INFO - Initialising browser for dromaeo_css test... 07:04:34 INFO - TEST-INFO | started process 20431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpelFGvb/profile http://localhost:55279/getInfo.html) 07:04:35 INFO - PROCESS | 20431 | 1483542275358 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4901 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3756 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2789 < callProvider()@resource://gre/modules/AddonManager.jsm:260 < _startProvider()@resource://gre/modules/AddonManager.jsm:755 < startup()@resource://gre/modules/AddonManager.jsm:937 < startup()@resource://gre/modules/AddonManager.jsm:2886 < observe()@resource://gre/components/addonManager.js:65 07:04:39 INFO - PROCESS | 20431 | __metrics Screen width/height:1600/1200 07:04:39 INFO - PROCESS | 20431 | colorDepth:24 07:04:39 INFO - PROCESS | 20431 | Browser inner width/height: 1024/697 07:04:39 INFO - PROCESS | 20431 | __metrics 07:04:40 ERROR - PROCESS | 20431 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 07:04:41 INFO - TEST-INFO | 20431: exit 0 07:04:41 INFO - Browser initialized. 07:04:41 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:41 INFO - TEST-INFO | started process 20553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpelFGvb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:53 INFO - PROCESS | 20553 | RSS: Main: 158232576 07:04:53 INFO - PROCESS | 20553 | 07:05:42 INFO - PROCESS | 20553 | 1483542342731 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:07:56 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:55279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55279/tests/dromaeo/cssquery-ext.html) 07:07:57 INFO - PROCESS | 20553 | RSS: Main: 164626432 07:07:57 INFO - PROCESS | 20553 | 07:09:41 INFO - PROCESS | 20553 | ************************* 07:09:41 INFO - PROCESS | 20553 | A coding exception was thrown and uncaught in a Task. 07:09:41 INFO - PROCESS | 20553 | 07:09:41 INFO - PROCESS | 20553 | Full message: ReferenceError: fetch is not defined 07:09:41 INFO - PROCESS | 20553 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:09:41 INFO - PROCESS | 20553 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:09:41 INFO - PROCESS | 20553 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:09:41 INFO - PROCESS | 20553 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:09:41 INFO - PROCESS | 20553 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:09:41 INFO - PROCESS | 20553 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:09:41 INFO - PROCESS | 20553 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:09:41 INFO - PROCESS | 20553 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:09:41 INFO - PROCESS | 20553 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:09:41 INFO - PROCESS | 20553 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:09:41 INFO - PROCESS | 20553 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:09:41 INFO - PROCESS | 20553 | 07:09:41 INFO - PROCESS | 20553 | ************************* 07:11:00 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:55279/tests/dromaeo/cssquery-ext.html (next: http://localhost:55279/tests/dromaeo/cssquery-jquery.html) 07:11:01 INFO - PROCESS | 20553 | RSS: Main: 162824192 07:11:01 INFO - PROCESS | 20553 | 07:14:03 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:55279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55279/tests/dromaeo/cssquery-mootools.html) 07:14:03 INFO - PROCESS | 20553 | RSS: Main: 168062976 07:14:03 INFO - PROCESS | 20553 | 07:17:06 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:55279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55279/tests/dromaeo/cssquery-prototype.html) 07:17:06 INFO - PROCESS | 20553 | RSS: Main: 162754560 07:17:06 INFO - PROCESS | 20553 | 07:20:09 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:55279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55279/tests/dromaeo/cssquery-yui.html) 07:20:10 INFO - PROCESS | 20553 | RSS: Main: 165773312 07:20:10 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:55279/tests/dromaeo/cssquery-yui.html (next: http://localhost:55279/tests/dromaeo/cssquery-dojo.html) 07:23:13 INFO - PROCESS | 20553 | RSS: Main: 166416384 07:23:13 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | __start_tp_report 07:23:13 INFO - PROCESS | 20553 | _x_x_mozilla_page_load 07:23:13 INFO - PROCESS | 20553 | _x_x_mozilla_page_load_details 07:23:13 INFO - PROCESS | 20553 | |i|pagename|runs| 07:23:13 INFO - PROCESS | 20553 | |0;dojo.html;2585.715571287158;2588.4564241509283;2594.1439325022743;2618.1360151150116;2622.6066090086474;4696.342512048316;4771.976140119299;4790.065937142254;4811.9654274331015;4815.807367705288;4692.319613656026;4722.763861806913;4772.451168115667;4810.783514741836;4813.66304358695;4320;4348.478182618082;4393.736375817445;4431.224535706238;4483.910321793563;4348.934765978513;4446.7554284514335;4463.062756821071;4472.508024117361;4500.414946057024;4246.363045543162;4272.807723652412;4376.6936314458;4382.758948257844;4416.447944006999;4286;4289.549597292302;4308.74147551148;4314.02934339771;4330.437043184366;4278.529361770203;4287.742735435884;4293.892652683708;4311.676624253194;4313.223619748444;4669.299605059235;4726.291056341542;4759.952400475986;4770.689905156189;4842.346283251751;5131.948680513185;5138.897222055575;5146.459621739701;5151.948480515184;5179.637425380225;5155.9742201288755;5165.509276618715;5174.534291913708;5175.818846340398;5177.119889618773;4634.930476042829;4672.509386514435;4775.21209000511;4801.399825021872;4841.8547443576745;5268.157094864803;5306.52241298285;5310.070737620901;5341.893162136813;5369.463053694677;5037.420696619863;5068.82259120929;5089.083964886282;5104.566111880532;5131.050755610224;4889.975550122226;4969.552740253394;5173.249878767558;5179.922301165486;5187.247849061865;4961.578265847371;4992.2511623256805;5000.4999500050435;5047.722375269395;5096.311997880312;5045.369328833895;5068.315777370081;5071.594272458195;5072.594192464594;5084.13569693153;4239.04621460169;4262.509811371732;4268.231718290675;4270.957290427118;4301.075268817157;3634.2186429917697;3637.8726744563814;3662.1943172502006;3688.5942546319884;3699.3711069118312;4423.51341352451;4424.513303536608;4430.623397011225;4440.755758433253;4461.486929003207;5073.898522029539;5097.413797413271;5128.794848206105;5151.0470562945975;5152.5362717354865;4292.48490181174;4314.633256173198;4317.827286908551;4359.237133501624;4435.379046933432;4484.8430304939175;4497.415336006364;4505.662075344362;4511.571400716926;4513.435820522434;4676.251799712098;4707.270373092108;4711.104890070876;4714.434267887876;4714.905701886011;5023.924641130459;5037.19404895215;5048.167052436307;5050.090983622983;5052.216906379517;4649.418822647169;4674.766261686834;4687.015726697432;4709.2936059589965;4724.551167639069;4959.107360675113;4976.0794253063295;4978.502149784992;4986.177280748636;4986.900261994812;5012.147934851157;5070.4929507049;5079.390473143247;5083.186690129562;5131.589472842089;4923.606111511142;4955.851324460272;4983.227599722049;4987.326710893983;5039.874003149951;5001.924971125363;5002.374703162105;5003.149464590955;5004.099262132851;5052.242163675478;4667.206574882346;4774.880627984328;4837.782299796448;4851.805927762991;4883.95116048835;5024.472430394756;5033.194688849767;5052.671576347672;5077.416097148875;5088.643794934319;4849.078675051729;4920.926186107283;4924.236743304794;4932.186189278729;4968.677035992793 07:23:13 INFO - PROCESS | 20553 | |1;ext.html;523.8873642166934;531.3066448284986;531.6145794299133;537.2371232849355;539.9109146990746;39841.4023789643;41383;41469.58530414699;44619.553804461946;44818;41010.58989410105;41677.37483937744;41683.58316416843;41719.791401043025;41869;7551.773446796591;7700;7709.267619576131;7713.34436572892;9419.952900235523;9348.719538413825;9503.334766566342;9570.665026724066;9673.129418352348;9675.322727409084;9615.471149086798;9620.230381569458;9662.468564228964;9663.130318271355;9671.468069256189;9414.388064775767;9442.905570944271;9445.386049906734;9468.715938521855;9489;9575.760605984906;9656.130948214695;9657.130858222723;9663.46850923206;9663.758406039835;33908.32183356344;34290.82854585736;34293.142671433416;34335.31329373398;34403.13992150191;3504.6144924058335;3578.4095624221973;3587.3004764071015;3613.313470440608;3658.7255955803157;25957.61063584029;26103.477930441284;26199.214023579323;26640.20079397621;27467.45065098687;3353.2958078803235;3373.9156521086925;3392;3436.879709210166;3437.2438063625964;155273;155630;155873;156139.99999999886;156335.2183239088;46700.53299466962;46969.53030469651;47075.05849882983;47142.764286178346;47245.76377118092;49213.75393123083;49281.26078108831;49372.3472861707;49522.50477495251;49645.25532117021;13699.726005479835;13853.445862165401;13868.930655346861;13876.444942202199;13930.791038134435;9651.90348096524;9731.9026809731;10223.233257505717;10581.047705706369;10782.892171078189;15574.688506229812;15637.452689155825;15683.686326273411;15711.292991815395;15817.446389376317;6410.455111315498;6435.485161187187;6501.9674901625185;6532.216134063943;6540.640264785482;747.5141158247183;773.9126527229251;780.3211206250598;781.2851241114316;784.4548039112761;24924.37689057788;26392.472150557267;26524.46951060968;26812.195634130618;26977;935.1116439382614;959.2661613865398;967.6081187119228;981.676046904534;986.7582442301539;13724.93137534306;14271.357788899317;14468.493602723855;14498.420063197354;14545.709085818437;367721;370448;370915;373132;373588;51146.74426627843;51238;51455.74272128615;51678.48321516737;51771;1179.336232860321;1210.2375503432957;1210.6126039667397;1227.2697744841805;1227.9877201228053;25324.873375633004;26420.867895660398;27095.86452067727;27463.313417163932;27703.168904932885;41630.79184604058;42390.99999999876;42543.57456425396;42584.361234582124;42595.57404425916;245030;246030;246039;247108;247268;22570.322890313317;22900.885495573082;25061.49877002486;25245.495090098462;25457.363565911;38788.61211387963;40800.38799417952;41076.589234107276;41429.58570414378;42110;35249.295014100084;35595.28809423849;36617.267654647294;37316.440253396766;37408.81295593505;35703.64296357003;36111;36202;36202.4569631461;36426.8178659105;33421.16447088842;33888.322233555686;33904.83047584746;34709.8264508686;34794;29626.555601666423;32269.838650806596;32351;32412.675873240965;32423.837880810446;23803.40491487727;24162.550246985236;24649;24699;25142.49715005726 07:23:13 INFO - PROCESS | 20553 | |2;jquery.html;345.37831902575357;353.90975301298164;356.43505044504457;356.86617518430586;366.8312576214941;15457.922710386447;15879.68240635188;16342.182890855469;16361.427350042752;16394.016359018467;14780.187089710089;15647.765283520728;16208.675826483463;16342.673146537061;16372;4940.827071052514;4946.9752651236695;5081.263216833576;5102.489751024887;5117.488251174871;4947.703137811743;4997.425296090942;5029.245613158019;5032.5470707636305;5057;4996.7001979881325;5020.497950204968;5027.924581131268;5271.262023316739;5281.70950597717;5282.102042652739;5317.5480084192695;5334.893302133974;5349.919751203735;5369.355677318707;5074.391073071218;5207.765650545697;5208.114620514521;5242.97378513105;5245.160774276135;11220.831687524693;11366.37484938328;11403.486843092081;11407.48666310018;18036.188371523313;2075.6056349293585;2085.7914208579173;2176.3906106290265;2187.9343619691435;2252.31304452142;8310.127436619128;8711.346649001287;8926.955365223132;11784.823227651592;12572.182808117443;1636.8444997725196;1701.8638508919257;1713.4431309824356;1729.541671457065;1773.911304434773;57688.71155644195;58942.11586826201;67661.32338676599;67901.32098679;68929;8100.189981001853;8217.465864718773;8505.659773608986;8712.869306960401;8719.782005449788;11076.833847492295;11079.944600277107;11154.721131971603;11155.330680159217;11180.888191118147;6296.685165741695;6751.594904305757;6807;6897.310049080863;6963.338482844122;6487.156669632917;7023;7031.191412987469;7111.53775004623;7192.136943566806;3531.752777305564;3586.3903136466865;3588.69496092835;3599.820008999592;3636.090977255686;1688.265604462063;1728.9654206916043;1760.779902512186;1771.539399756047;1791.435697755203;791.7545560876147;792.1247022040677;801.703369753195;802.7631848604676;804.798800299925;15217.467388641344;15628.765568516481;16062.43781467643;16119.194040297938;16138.75791863123;930.9162175404247;933.0343094896749;936.896941336466;944.5985456181232;956.7420886707365;8708.17272359125;8735.694250701195;9041;9144.908550914539;9188.127127922837;270615;274078;366319;371688;372109;54813;54909.450905491234;55343.72328138333;55745.442545574835;69044.30955690479;913.2100732866156;946.8295706772985;957.593022965237;959.2326139088701;966;14918.77621835695;14970.176640284453;15034.17312047848;15338.386464541294;15631.687366252838;28476.85761571262;33947.66052339445;34634.307313854086;34742.305153896275;35618.10954726153;49164.75417622889;49959.75020124876;49993.50006499889;50157;51943;7010.929890701028;7021.894671580033;7082.3979961703835;7317.085364329459;7594;8079.636416361161;10320.48397580103;11004.229703920648;11183.776324473627;11601.535938562363;9373.250139988648;9431.717048488556;9643.357235756874;10135.290529662852;10180.389176649425;9079.909200907907;9216.170544651013;9852.359596626196;10129.290949633454;10872.07587355052;9874.901250987397;9909.306348555532;9925.305228633926;10419.270651054354;10636.89363106359;7096.929030709627;7334.3032411920785;7426.554406735397;7452.552846829208;7674.8081297968;9811.509424528887;10282.383057016603;10295.94852025735;10459.110975567162;10758.569657213624 07:23:13 INFO - PROCESS | 20553 | |3;mootools.html;1336.1916040795318;1336.939837707303;1343.0464370297088;1343.3216225805966;1356.9389377478014;6315.873682526347;6562.770303039395;6760.830979225516;7136.072310599621;7142.500024998246;6860.622665753382;6983;7024.648767561627;7201;7262.128544574645;2083.395815213586;2115.206797450956;2119.067610251492;2124.2671278408925;2125.278524395237;2058.752949646037;2101.95796084079;2107.557412943284;2112.2818241797786;2165.9566808663817;2059.9485012874648;2061.402193363923;2075.335892514396;2087.759907610629;2089.7387826521685;2024.2409096588779;2025.7265269188692;2027.8174964253287;2048.7541495020546;2060.258307009475;2097.2030628361276;2104.4318034130697;2121.31057406342;2137.5938571671486;2140.646793279107;7221.8555628887125;7239.420846332281;7241.746538871167;7247.20280769115;7257.092863392076;4365.323374876899;4484.349769283435;4495.955040449587;4510.977445112786;4515.525869783658;2724.0820340072282;2787.2892412434903;2828.9575656364964;2866.856657167133;2882.6396700412447;1039.4283144270696;1039.7036844499282;1072.2440679321137;1081.6268387406333;1090.8091084060259;9413.341066125375;9450;9473.100055494717;9473.66842160528;9529.428234305895;3799.3731034379016;3802.733808633369;3832.6358995895903;3854.807259637007;3889.9027524311555;7629.122650895218;7665.118511371264;7669.271419215165;7671.232876712284;7673.424493162924;4312.202242585132;4319.784010799447;4320.783960801948;4320.956790432118;4325.567443255649;3917.373220284741;4000.119973605802;4008.579099194543;4024.1348110155873;4027.859024934113;3130.358276553301;3151.16494129056;3189.617245930503;3222.065600975691;3258.0714496368896;886.3131073418024;910.5492781073278;944.3531181140941;964.4358050540372;969.2536746704998;849.562475325208;855.3029281135854;869.2046777198918;888.7156110044724;890.5903284489208;4738.431388233434;4864.78108485119;4881.755912204447;4986.700797952134;4987.850364489072;838.8112674648278;873.4802792338548;875.8861348024716;878.2052242720348;880.221004411088;3347.464405695077;3441.2257242120822;3493.179102910814;3497.440409534462;3548.1484443733316;7830.138684744674;8277.917220827714;8608.48349099056;8655.264302534355;8664.046954834963;7971.481853679608;8270.958645206856;8272.17278272168;8277.751667449986;8296.585170741439;6662.700178491979;6727.125473688389;6774.45804335652;6821.1814582250445;6854.760083397057;4913.705177689207;4966.8758281043265;4970.826021089245;5078.187490001582;5120.820771272987;7856.84286314282;7879.448438609472;7885.172056934169;7891.84216315682;7920.801979950317;7441.8139546511775;7822.413319000984;7835.37317014626;7932.127465978853;8039.1156972734125;6095.329513753395;6198.907016394848;6201.751929922933;6210.937890621217;6223.626582405071;6595.406413422815;6643.634600097041;6685.364890335411;6695.531312808057;6707.698153583003;5867.9413205869105;6053.243344581927;6163.075538669056;6223.595466294676;6276.1213430118905;5907.350191478848;5953;5955.493783028491;5959.612625179349;5986.221791167294;5310.230016647642;5380.354357476971;5390.434004429479;5403.945960540502;5418.403975562764;4043.2115737432096;4069.2268468990796;4101.159262351271;4273.850415235452;4362.127574485052;4171.520275168273;4224.725392849455;4241.703080784316;4260.126674031878;4274.95725042758 07:23:13 INFO - PROCESS | 20553 | |4;prototype.html;319.678722883502;326.33264973129945;330.0445211113825;331.05318788265555;334.51662347907285;4819.518048195178;4964.205727083668;5042.924356134661;5047.343845300111;5084.44071152173;4835.903281934368;4913.459519452857;4926.029588164736;4958.3885237297845;4965.939135258872;3776.9055773605605;3782.1301100746846;3786.75386099904;3797.810109494528;3812.1613245086037;3814.1227517670955;3822.4710115953562;3830.751001184914;3831.731778775487;3847.8845634631007;3651.379265524867;3739.813009349535;3775.924481510368;3801.5248093988253;3821.522309711286;3764.9623503764888;3777.5466943966626;3778.5465744110884;3789.1663833956486;3792.7950881505085;3292.983535082333;3322.684344987222;3329.167708072982;3329.267561136546;3347.397468455677;4739.976300118512;4798.592119669797;4915.877103072416;4919.065377578248;4935.555799977983;4297.58179800665;4323.3947247385395;4334.198173337911;4347.391365208873;4358.193734159159;5193.844184674465;5197.896042079137;5199.558037566811;5221.650257384154;5246.449122842085;3621.692156166729;3648.3068217038676;3653.3058718843336;3653.799041052741;3658.6890114340313;5199.766010529535;5384.7846086156505;5455.781768729246;5487.64330318528;5492.642978206404;3683.342495876866;3697.9815100924325;3707.258548290353;3718.200586873835;3734.9066273343383;3743.996961625517;3752.45589389537;3756.718246131551;3768.8680896168503;3779.7921114338424;4128.422020917074;4302;4324.740515569076;4325.567443255649;4352.934705979413;5237.240600113038;5241.42344342122;5259.737013149327;5265.552428043583;5290.285811415487;1235.8516977962702;1243.111175509515;1252.642996745923;1258.7104965857905;1273;821.6877586517205;847.5423271433481;847.6948298612494;855.085058986878;856.6892654239024;4378.693491455568;4380.255356589388;4396.736195828261;4409.33859921008;4425.247707889666;5206.557442617344;5213.7393130343335;5216.7913283469;5218.373795144607;5242.1914439518305;4458.302726850209;4462.527365969222;4483.618892394118;4496.325551167286;4500.054988452396;2654.230273220783;2747.986260068687;2768.076187050021;2773.320536468578;2797.384575393451;4771.5228477152;4774.976125119421;4778.235482322812;4795.544423279783;4833.453294945654;5107.719075450886;5290.894182116336;5316.46835316473;5328.6802791832615;5349.956758432068;4809.5430934061205;4838.758062096951;4855.927161092586;4868.02639472107;4898.804047838118;5139.92290115656;5157.174852023658;5168.53483186515;5228.294180285613;5231.712255825966;5007.122329126578;5087.847364579068;5110.565601923878;5131.640785145004;5145.404924473425;4761.523847615211;4817.9518204818905;4820.517948205152;4825.300331451849;4834.540718631724;3561.4479755637917;3571.303595798898;3580.0691820126435;3584.6773790358993;3597.9820100900374;4906.828261010847;5160.767765450489;5164.845054648366;5186.377634683862;5187.870303242449;5051.974740126276;5073.365829271341;5075.705695047739;5077.92383114261;5122.334096567422;4928.236123400879;4968;5073.213651883964;5085.847424577269;5089.236614507853;4861.829835955725;4883.633727470383;4980.211081794207;5021.698698078127;5024.71869673231;5223.686578805284;5272.472752724697;5272.497338258578;5285.229448134918;5296.496832800878;5139.254808052737;5141.5629671476845;5164.431912489548;5166.793328266827;5213.348331458567 07:23:13 INFO - PROCESS | 20553 | |5;yui.html;645.895153313551;657.9934200657989;722.7542635503929;723.2803360656148;750.3134631811893;12088.516459341627;13419.261940593264;13645.727085458286;13658.38537265823;13674.384652690627;12479.937600311985;12496.56262030829;12649.17780344277;12689.428975696093;12833.871661283385;660.1253339325389;674.8650269946006;777.8522080804657;779.6959185917497;799.2087833045273;793.6983946100473;810.8297257575887;813.4875028731891;816.7263966571206;817.3216230528647;855.3798496090347;856.7686724584358;857.8327226190895;861.5907443964098;862.0991064337751;835.9832803343929;844.269706703703;849.371465115816;855.8416692911832;860.7116615933638;625.1341891480287;625.1778910732372;626.7399029402792;626.8088233088906;628.3339659960457;13170.407331670098;13241.801372979413;13427.66430839227;13473.326333683277;14019.228942408163;13737.313134343343;14280.785788213185;14382.640433989129;14519.70960580793;14635.268236588234;10612.151027917747;10710;10716.892831071746;10757.892421075767;10770.4614769262;3259.494778309342;3330.184104894292;3377.7973321600784;3379.8141102239365;3465.740069494798;68335;68380.6580967092;68459.3154068458;69443;70499;9697.175740062032;9732.854007189897;9936.205103591696;10234.232432567587;11071.280366776135;16529.752053719203;16735.91632041832;16785.66428671444;16808.411705590246;16824;6291.087792270096;6409.647469389229;6524.6737663116655;6558.770443034471;6621.4040736333;3581.982090089533;3606.13452771333;3622.239329740731;3642.9817850910576;3666.871659491905;2950.9409811803644;2953.9556906646417;2968.0650595062916;2975.821450712921;3004.4291584598855;490.8110377504615;491.09883364026695;498.48904872505244;500.6395395315367;505.2875445621656;624.6283461340495;627.5826575327447;640.2828831708516;647.6017249391684;654.8115170964684;8232.094469608339;8295.668173273001;8422.452540584965;8586.430046053641;8887.200151986352;606.8634557224677;614.1647359590953;633.9302676705558;634.6731433311849;634.7968650031945;4033.9925248381937;4170.708050436501;4245.787710614457;4276.1661476012505;4297.312430011183;66749;68547.31452685509;69747.65126174336;70821.64589177124;71421;58493;59579;59916;62687.6865615669;63370.36629633737;54084;54444;54643;54930.45069549333;55167.448325516234;7764.84470310602;8076.515409075474;8110.675572977015;8210.425270231266;8274.710385136492;37213.25573488569;37445.625543744216;37960.62039379571;39139.6086039136;39465.60534394734;46357;47188.76405618087;47278.81802954953;47395.52604473911;48543.757281213366;9386.906130938876;9447.480388578419;9509.667161649586;9656.130948214695;9732.61069557238;10845.891541084804;10875.836862446911;11089.778204436028;11239.100871930063;11273.436328183394;10327.535260913428;10554.894451055392;10593.470326483799;10736.141108711441;10876.12990960737;10483.947580262049;10501.527431265458;10713.303635263683;10828.18788590843;10944.507497162806;11632.360220187971;11883.940580297389;11902.464389102684;11983.820242696193;12056;9481.715548533555;9714.562844671866;10050.89949100529;10070.69787906364;10355.17158627323;9293.953530232306;9953.950230248802;10023.448710321003;10131.240156988108;10295.588176472857 07:23:13 INFO - PROCESS | 20553 | __end_tp_report 07:23:13 INFO - PROCESS | 20553 | __start_cc_report 07:23:13 INFO - PROCESS | 20553 | _x_x_mozilla_cycle_collect,334 07:23:13 INFO - PROCESS | 20553 | __end_cc_report 07:23:13 INFO - PROCESS | 20553 | __startTimestamp1483543393248__endTimestamp 07:23:13 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | ------- Summary: start ------- 07:23:13 INFO - PROCESS | 20553 | Number of tests: 6 07:23:13 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | [#0] dojo.html Cycles:165 Average:4694.25 Median:4811.97 stddev:517.62 (10.8%) stddev-sans-first:492.07 07:23:13 INFO - PROCESS | 20553 | Values: 2585.7 2588.5 2594.1 2618.1 2622.6 4696.3 4772.0 4790.1 4812.0 4815.8 4692.3 4722.8 4772.5 4810.8 4813.7 4320.0 4348.5 4393.7 4431.2 4483.9 4348.9 4446.8 4463.1 4472.5 4500.4 4246.4 4272.8 4376.7 4382.8 4416.4 4286.0 4289.5 4308.7 4314.0 4330.4 4278.5 4287.7 4293.9 4311.7 4313.2 4669.3 4726.3 4760.0 4770.7 4842.3 5131.9 5138.9 5146.5 5151.9 5179.6 5156.0 5165.5 5174.5 5175.8 5177.1 4634.9 4672.5 4775.2 4801.4 4841.9 5268.2 5306.5 5310.1 5341.9 5369.5 5037.4 5068.8 5089.1 5104.6 5131.1 4890.0 4969.6 5173.2 5179.9 5187.2 4961.6 4992.3 5000.5 5047.7 5096.3 5045.4 5068.3 5071.6 5072.6 5084.1 4239.0 4262.5 4268.2 4271.0 4301.1 3634.2 3637.9 3662.2 3688.6 3699.4 4423.5 4424.5 4430.6 4440.8 4461.5 5073.9 5097.4 5128.8 5151.0 5152.5 4292.5 4314.6 4317.8 4359.2 4435.4 4484.8 4497.4 4505.7 4511.6 4513.4 4676.3 4707.3 4711.1 4714.4 4714.9 5023.9 5037.2 5048.2 5050.1 5052.2 4649.4 4674.8 4687.0 4709.3 4724.6 4959.1 4976.1 4978.5 4986.2 4986.9 5012.1 5070.5 5079.4 5083.2 5131.6 4923.6 4955.9 4983.2 4987.3 5039.9 5001.9 5002.4 5003.1 5004.1 5052.2 4667.2 4774.9 4837.8 4851.8 4884.0 5024.5 5033.2 5052.7 5077.4 5088.6 4849.1 4920.9 4924.2 4932.2 4968.7 07:23:13 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | [#1] ext.html Cycles:180 Average:41855.99 Median:202169.13 stddev:71785.18 (35.5%) stddev-sans-first:71919.47 07:23:13 INFO - PROCESS | 20553 | Values: 523.9 531.3 531.6 537.2 539.9 39841.4 41383.0 41469.6 44619.6 44818.0 41010.6 41677.4 41683.6 41719.8 41869.0 7551.8 7700.0 7709.3 7713.3 9420.0 9348.7 9503.3 9570.7 9673.1 9675.3 9615.5 9620.2 9662.5 9663.1 9671.5 9414.4 9442.9 9445.4 9468.7 9489.0 9575.8 9656.1 9657.1 9663.5 9663.8 33908.3 34290.8 34293.1 34335.3 34403.1 3504.6 3578.4 3587.3 3613.3 3658.7 25957.6 26103.5 26199.2 26640.2 27467.5 3353.3 3373.9 3392.0 3436.9 3437.2 155273.0 155630.0 155873.0 156140.0 156335.2 46700.5 46969.5 47075.1 47142.8 47245.8 49213.8 49281.3 49372.3 49522.5 49645.3 13699.7 13853.4 13868.9 13876.4 13930.8 9651.9 9731.9 10223.2 10581.0 10782.9 15574.7 15637.5 15683.7 15711.3 15817.4 6410.5 6435.5 6502.0 6532.2 6540.6 747.5 773.9 780.3 781.3 784.5 24924.4 26392.5 26524.5 26812.2 26977.0 935.1 959.3 967.6 981.7 986.8 13724.9 14271.4 14468.5 14498.4 14545.7 367721.0 370448.0 370915.0 373132.0 373588.0 51146.7 51238.0 51455.7 51678.5 51771.0 1179.3 1210.2 1210.6 1227.3 1228.0 25324.9 26420.9 27095.9 27463.3 27703.2 41630.8 42391.0 42543.6 42584.4 42595.6 245030.0 246030.0 246039.0 247108.0 247268.0 22570.3 22900.9 25061.5 25245.5 25457.4 38788.6 40800.4 41076.6 41429.6 42110.0 35249.3 35595.3 36617.3 37316.4 37408.8 35703.6 36111.0 36202.0 36202.5 36426.8 33421.2 33888.3 33904.8 34709.8 34794.0 29626.6 32269.8 32351.0 32412.7 32423.8 23803.4 24162.6 24649.0 24699.0 25142.5 07:23:13 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | [#2] jquery.html Cycles:180 Average:21330.55 Median:5024.21 stddev:55193.16 (1098.5%) stddev-sans-first:55325.50 07:23:13 INFO - PROCESS | 20553 | Values: 345.4 353.9 356.4 356.9 366.8 15457.9 15879.7 16342.2 16361.4 16394.0 14780.2 15647.8 16208.7 16342.7 16372.0 4940.8 4947.0 5081.3 5102.5 5117.5 4947.7 4997.4 5029.2 5032.5 5057.0 4996.7 5020.5 5027.9 5271.3 5281.7 5282.1 5317.5 5334.9 5349.9 5369.4 5074.4 5207.8 5208.1 5243.0 5245.2 11220.8 11366.4 11403.5 11407.5 18036.2 2075.6 2085.8 2176.4 2187.9 2252.3 8310.1 8711.3 8927.0 11784.8 12572.2 1636.8 1701.9 1713.4 1729.5 1773.9 57688.7 58942.1 67661.3 67901.3 68929.0 8100.2 8217.5 8505.7 8712.9 8719.8 11076.8 11079.9 11154.7 11155.3 11180.9 6296.7 6751.6 6807.0 6897.3 6963.3 6487.2 7023.0 7031.2 7111.5 7192.1 3531.8 3586.4 3588.7 3599.8 3636.1 1688.3 1729.0 1760.8 1771.5 1791.4 791.8 792.1 801.7 802.8 804.8 15217.5 15628.8 16062.4 16119.2 16138.8 930.9 933.0 936.9 944.6 956.7 8708.2 8735.7 9041.0 9144.9 9188.1 270615.0 274078.0 366319.0 371688.0 372109.0 54813.0 54909.5 55343.7 55745.4 69044.3 913.2 946.8 957.6 959.2 966.0 14918.8 14970.2 15034.2 15338.4 15631.7 28476.9 33947.7 34634.3 34742.3 35618.1 49164.8 49959.8 49993.5 50157.0 51943.0 7010.9 7021.9 7082.4 7317.1 7594.0 8079.6 10320.5 11004.2 11183.8 11601.5 9373.3 9431.7 9643.4 10135.3 10180.4 9079.9 9216.2 9852.4 10129.3 10872.1 9874.9 9909.3 9925.3 10419.3 10636.9 7096.9 7334.3 7426.6 7452.6 7674.8 9811.5 10282.4 10295.9 10459.1 10758.6 07:23:13 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | [#3] mootools.html Cycles:180 Average:4654.46 Median:5345.29 stddev:2479.00 (46.4%) stddev-sans-first:2473.41 07:23:13 INFO - PROCESS | 20553 | Values: 1336.2 1336.9 1343.0 1343.3 1356.9 6315.9 6562.8 6760.8 7136.1 7142.5 6860.6 6983.0 7024.6 7201.0 7262.1 2083.4 2115.2 2119.1 2124.3 2125.3 2058.8 2102.0 2107.6 2112.3 2166.0 2059.9 2061.4 2075.3 2087.8 2089.7 2024.2 2025.7 2027.8 2048.8 2060.3 2097.2 2104.4 2121.3 2137.6 2140.6 7221.9 7239.4 7241.7 7247.2 7257.1 4365.3 4484.3 4496.0 4511.0 4515.5 2724.1 2787.3 2829.0 2866.9 2882.6 1039.4 1039.7 1072.2 1081.6 1090.8 9413.3 9450.0 9473.1 9473.7 9529.4 3799.4 3802.7 3832.6 3854.8 3889.9 7629.1 7665.1 7669.3 7671.2 7673.4 4312.2 4319.8 4320.8 4321.0 4325.6 3917.4 4000.1 4008.6 4024.1 4027.9 3130.4 3151.2 3189.6 3222.1 3258.1 886.3 910.5 944.4 964.4 969.3 849.6 855.3 869.2 888.7 890.6 4738.4 4864.8 4881.8 4986.7 4987.9 838.8 873.5 875.9 878.2 880.2 3347.5 3441.2 3493.2 3497.4 3548.1 7830.1 8277.9 8608.5 8655.3 8664.0 7971.5 8271.0 8272.2 8277.8 8296.6 6662.7 6727.1 6774.5 6821.2 6854.8 4913.7 4966.9 4970.8 5078.2 5120.8 7856.8 7879.4 7885.2 7891.8 7920.8 7441.8 7822.4 7835.4 7932.1 8039.1 6095.3 6198.9 6201.8 6210.9 6223.6 6595.4 6643.6 6685.4 6695.5 6707.7 5867.9 6053.2 6163.1 6223.6 6276.1 5907.4 5953.0 5955.5 5959.6 5986.2 5310.2 5380.4 5390.4 5403.9 5418.4 4043.2 4069.2 4101.2 4273.9 4362.1 4171.5 4224.7 4241.7 4260.1 4275.0 07:23:13 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | [#4] prototype.html Cycles:180 Average:4232.10 Median:4822.91 stddev:1240.10 (25.7%) stddev-sans-first:1208.31 07:23:13 INFO - PROCESS | 20553 | Values: 319.7 326.3 330.0 331.1 334.5 4819.5 4964.2 5042.9 5047.3 5084.4 4835.9 4913.5 4926.0 4958.4 4965.9 3776.9 3782.1 3786.8 3797.8 3812.2 3814.1 3822.5 3830.8 3831.7 3847.9 3651.4 3739.8 3775.9 3801.5 3821.5 3765.0 3777.5 3778.5 3789.2 3792.8 3293.0 3322.7 3329.2 3329.3 3347.4 4740.0 4798.6 4915.9 4919.1 4935.6 4297.6 4323.4 4334.2 4347.4 4358.2 5193.8 5197.9 5199.6 5221.7 5246.4 3621.7 3648.3 3653.3 3653.8 3658.7 5199.8 5384.8 5455.8 5487.6 5492.6 3683.3 3698.0 3707.3 3718.2 3734.9 3744.0 3752.5 3756.7 3768.9 3779.8 4128.4 4302.0 4324.7 4325.6 4352.9 5237.2 5241.4 5259.7 5265.6 5290.3 1235.9 1243.1 1252.6 1258.7 1273.0 821.7 847.5 847.7 855.1 856.7 4378.7 4380.3 4396.7 4409.3 4425.2 5206.6 5213.7 5216.8 5218.4 5242.2 4458.3 4462.5 4483.6 4496.3 4500.1 2654.2 2748.0 2768.1 2773.3 2797.4 4771.5 4775.0 4778.2 4795.5 4833.5 5107.7 5290.9 5316.5 5328.7 5350.0 4809.5 4838.8 4855.9 4868.0 4898.8 5139.9 5157.2 5168.5 5228.3 5231.7 5007.1 5087.8 5110.6 5131.6 5145.4 4761.5 4818.0 4820.5 4825.3 4834.5 3561.4 3571.3 3580.1 3584.7 3598.0 4906.8 5160.8 5164.8 5186.4 5187.9 5052.0 5073.4 5075.7 5077.9 5122.3 4928.2 4968.0 5073.2 5085.8 5089.2 4861.8 4883.6 4980.2 5021.7 5024.7 5223.7 5272.5 5272.5 5285.2 5296.5 5139.3 5141.6 5164.4 5166.8 5213.3 07:23:13 INFO - PROCESS | 20553 | 07:23:13 INFO - PROCESS | 20553 | [#5] yui.html Cycles:180 Average:15224.44 Median:499.56 stddev:19689.29 (3941.3%) stddev-sans-first:19714.09 07:23:13 INFO - PROCESS | 20553 | Values: 645.9 658.0 722.8 723.3 750.3 12088.5 13419.3 13645.7 13658.4 13674.4 12479.9 12496.6 12649.2 12689.4 12833.9 660.1 674.9 777.9 779.7 799.2 793.7 810.8 813.5 816.7 817.3 855.4 856.8 857.8 861.6 862.1 836.0 844.3 849.4 855.8 860.7 625.1 625.2 626.7 626.8 628.3 13170.4 13241.8 13427.7 13473.3 14019.2 13737.3 14280.8 14382.6 14519.7 14635.3 10612.2 10710.0 10716.9 10757.9 10770.5 3259.5 3330.2 3377.8 3379.8 3465.7 68335.0 68380.7 68459.3 69443.0 70499.0 9697.2 9732.9 9936.2 10234.2 11071.3 16529.8 16735.9 16785.7 16808.4 16824.0 6291.1 6409.6 6524.7 6558.8 6621.4 3582.0 3606.1 3622.2 3643.0 3666.9 2950.9 2954.0 2968.1 2975.8 3004.4 490.8 491.1 498.5 500.6 505.3 624.6 627.6 640.3 647.6 654.8 8232.1 8295.7 8422.5 8586.4 8887.2 606.9 614.2 633.9 634.7 634.8 4034.0 4170.7 4245.8 4276.2 4297.3 66749.0 68547.3 69747.7 70821.6 71421.0 58493.0 59579.0 59916.0 62687.7 63370.4 54084.0 54444.0 54643.0 54930.5 55167.4 7764.8 8076.5 8110.7 8210.4 8274.7 37213.3 37445.6 37960.6 39139.6 39465.6 46357.0 47188.8 47278.8 47395.5 48543.8 9386.9 9447.5 9509.7 9656.1 9732.6 10845.9 10875.8 11089.8 11239.1 11273.4 10327.5 10554.9 10593.5 10736.1 10876.1 10483.9 10501.5 10713.3 10828.2 10944.5 11632.4 11883.9 11902.5 11983.8 12056.0 9481.7 9714.6 10050.9 10070.7 10355.2 9294.0 9954.0 10023.4 10131.2 10295.6 07:23:13 INFO - PROCESS | 20553 | -------- Summary: end -------- 07:23:13 INFO - PROCESS | 20553 | 07:23:14 INFO - TEST-INFO | 20553: exit 0 07:23:14 INFO - TEST-OK | dromaeo_css | took 1119265ms 07:23:14 INFO - TEST-START | kraken 07:23:14 INFO - operating with platform_type : linux_ 07:23:14 INFO - Initialising browser for kraken test... 07:23:14 INFO - TEST-INFO | started process 20907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqRB4zN/profile http://localhost:55279/getInfo.html) 07:23:14 INFO - PROCESS | 20907 | 1483543394621 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4901 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3756 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2789 < callProvider()@resource://gre/modules/AddonManager.jsm:260 < _startProvider()@resource://gre/modules/AddonManager.jsm:755 < startup()@resource://gre/modules/AddonManager.jsm:937 < startup()@resource://gre/modules/AddonManager.jsm:2886 < observe()@resource://gre/components/addonManager.js:65 07:23:18 INFO - PROCESS | 20907 | __metrics Screen width/height:1600/1200 07:23:18 INFO - PROCESS | 20907 | colorDepth:24 07:23:18 INFO - PROCESS | 20907 | Browser inner width/height: 1024/697 07:23:18 INFO - PROCESS | 20907 | __metrics 07:23:19 ERROR - PROCESS | 20907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 07:23:20 INFO - TEST-INFO | 20907: exit 0 07:23:20 INFO - Browser initialized. 07:23:20 INFO - Running cycle 1/1 for kraken test... 07:23:20 INFO - TEST-INFO | started process 21029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqRB4zN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:32 INFO - PROCESS | 21029 | RSS: Main: 158490624 07:23:32 INFO - PROCESS | 21029 | 07:23:34 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55279/tests/kraken/driver.html?testName=audio-beat-detection) 07:23:35 INFO - PROCESS | 21029 | RSS: Main: 164327424 07:23:35 INFO - PROCESS | 21029 | 07:23:38 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55279/tests/kraken/driver.html?testName=audio-dft) 07:23:39 INFO - PROCESS | 21029 | RSS: Main: 162816000 07:23:39 INFO - PROCESS | 21029 | 07:23:42 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55279/tests/kraken/driver.html?testName=audio-fft) 07:23:42 INFO - PROCESS | 21029 | RSS: Main: 160133120 07:23:42 INFO - PROCESS | 21029 | 07:23:45 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55279/tests/kraken/driver.html?testName=audio-oscillator) 07:23:45 INFO - PROCESS | 21029 | RSS: Main: 160378880 07:23:45 INFO - PROCESS | 21029 | 07:23:47 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:48 INFO - PROCESS | 21029 | RSS: Main: 160317440 07:23:48 INFO - PROCESS | 21029 | 07:23:51 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55279/tests/kraken/driver.html?testName=imaging-darkroom) 07:23:52 INFO - PROCESS | 21029 | RSS: Main: 165470208 07:23:52 INFO - PROCESS | 21029 | 07:23:55 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55279/tests/kraken/driver.html?testName=imaging-desaturate) 07:23:56 INFO - PROCESS | 21029 | RSS: Main: 162222080 07:23:56 INFO - PROCESS | 21029 | 07:23:59 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55279/tests/kraken/driver.html?testName=json-parse-financial) 07:23:59 INFO - PROCESS | 21029 | RSS: Main: 162820096 07:23:59 INFO - PROCESS | 21029 | 07:24:01 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:24:02 INFO - PROCESS | 21029 | RSS: Main: 163299328 07:24:02 INFO - PROCESS | 21029 | 07:24:04 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55279/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:24:04 INFO - PROCESS | 21029 | RSS: Main: 163532800 07:24:04 INFO - PROCESS | 21029 | 07:24:07 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:24:07 INFO - PROCESS | 21029 | RSS: Main: 164003840 07:24:07 INFO - PROCESS | 21029 | 07:24:10 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:24:11 INFO - PROCESS | 21029 | RSS: Main: 164212736 07:24:11 INFO - PROCESS | 21029 | 07:24:14 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:24:15 INFO - PROCESS | 21029 | RSS: Main: 163987456 07:24:15 INFO - PROCESS | 21029 | 07:24:16 INFO - PROCESS | 21029 | Cycle 1(1): loaded http://localhost:55279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55279/tests/kraken/driver.html?testName=ai-astar) 07:24:17 INFO - PROCESS | 21029 | RSS: Main: 165703680 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | __start_tp_report 07:24:17 INFO - PROCESS | 21029 | _x_x_mozilla_page_load 07:24:17 INFO - PROCESS | 21029 | _x_x_mozilla_page_load_details 07:24:17 INFO - PROCESS | 21029 | |i|pagename|runs| 07:24:17 INFO - PROCESS | 21029 | |0;ai-astar;110;118;115;116;115;117;116;116;115;116 07:24:17 INFO - PROCESS | 21029 | |1;audio-beat-detection;153;130;129;176;129;130;132;130;150;134 07:24:17 INFO - PROCESS | 21029 | |2;audio-dft;165;167;166;172;164;163;164;164;163;164 07:24:17 INFO - PROCESS | 21029 | |3;audio-fft;76;78;78;113;77;77;76;77;106;78 07:24:17 INFO - PROCESS | 21029 | |4;audio-oscillator;85;84;121;85;85;85;98;85;86;115 07:24:17 INFO - PROCESS | 21029 | |5;imaging-gaussian-blur;118;119;119;118;117;120;118;119;119;118 07:24:17 INFO - PROCESS | 21029 | |6;imaging-darkroom;151;151;150;151;150;152;151;151;150;151 07:24:17 INFO - PROCESS | 21029 | |7;imaging-desaturate;97;96;97;96;96;97;95;96;97;96 07:24:17 INFO - PROCESS | 21029 | |8;json-parse-financial;68;68;68;69;69;74;69;68;69;69 07:24:17 INFO - PROCESS | 21029 | |9;json-stringify-tinderbox;68;67;67;68;73;68;66;67;71;68 07:24:17 INFO - PROCESS | 21029 | |10;stanford-crypto-aes;84;85;91;86;85;86;85;84;86;87 07:24:17 INFO - PROCESS | 21029 | |11;stanford-crypto-ccm;136;147;142;142;137;135;144;155;220;137 07:24:17 INFO - PROCESS | 21029 | |12;stanford-crypto-pbkdf2;185;176;183;178;183;181;178;176;177;179 07:24:17 INFO - PROCESS | 21029 | |13;stanford-crypto-sha256-iterative;74;70;69;71;71;69;70;70;68;68 07:24:17 INFO - PROCESS | 21029 | __end_tp_report 07:24:17 INFO - PROCESS | 21029 | __start_cc_report 07:24:17 INFO - PROCESS | 21029 | _x_x_mozilla_cycle_collect,792 07:24:17 INFO - PROCESS | 21029 | __end_cc_report 07:24:17 INFO - PROCESS | 21029 | __startTimestamp1483543457118__endTimestamp 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | ------- Summary: start ------- 07:24:17 INFO - PROCESS | 21029 | Number of tests: 14 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:2.12 (1.8%) stddev-sans-first:1.00 07:24:17 INFO - PROCESS | 21029 | Values: 110.0 118.0 115.0 116.0 115.0 117.0 116.0 116.0 115.0 116.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:133.00 stddev:15.64 (11.8%) stddev-sans-first:15.79 07:24:17 INFO - PROCESS | 21029 | Values: 153.0 130.0 129.0 176.0 129.0 130.0 132.0 130.0 150.0 134.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:2.70 (1.6%) stddev-sans-first:2.86 07:24:17 INFO - PROCESS | 21029 | Values: 165.0 167.0 166.0 172.0 164.0 163.0 164.0 164.0 163.0 164.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:13.77 (17.9%) stddev-sans-first:14.33 07:24:17 INFO - PROCESS | 21029 | Values: 76.0 78.0 78.0 113.0 77.0 77.0 76.0 77.0 106.0 78.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:85.00 stddev:13.92 (16.4%) stddev-sans-first:14.46 07:24:17 INFO - PROCESS | 21029 | Values: 85.0 84.0 121.0 85.0 85.0 85.0 98.0 85.0 86.0 115.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 07:24:17 INFO - PROCESS | 21029 | Values: 118.0 119.0 119.0 118.0 117.0 120.0 118.0 119.0 119.0 118.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:24:17 INFO - PROCESS | 21029 | Values: 151.0 151.0 150.0 151.0 150.0 152.0 151.0 151.0 150.0 151.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 07:24:17 INFO - PROCESS | 21029 | Values: 97.0 96.0 97.0 96.0 96.0 97.0 95.0 96.0 97.0 96.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:1.79 (2.6%) stddev-sans-first:1.86 07:24:17 INFO - PROCESS | 21029 | Values: 68.0 68.0 68.0 69.0 69.0 74.0 69.0 68.0 69.0 69.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:2.11 (3.1%) stddev-sans-first:2.24 07:24:17 INFO - PROCESS | 21029 | Values: 68.0 67.0 67.0 68.0 73.0 68.0 66.0 67.0 71.0 68.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:2.02 (2.4%) stddev-sans-first:2.03 07:24:17 INFO - PROCESS | 21029 | Values: 84.0 85.0 91.0 86.0 85.0 86.0 85.0 84.0 86.0 87.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:143.00 stddev:25.50 (17.8%) stddev-sans-first:26.58 07:24:17 INFO - PROCESS | 21029 | Values: 136.0 147.0 142.0 142.0 137.0 135.0 144.0 155.0 220.0 137.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:180.00 stddev:3.20 (1.8%) stddev-sans-first:2.74 07:24:17 INFO - PROCESS | 21029 | Values: 185.0 176.0 183.0 178.0 183.0 181.0 178.0 176.0 177.0 179.0 07:24:17 INFO - PROCESS | 21029 | 07:24:17 INFO - PROCESS | 21029 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.76 (2.5%) stddev-sans-first:1.13 07:24:17 INFO - PROCESS | 21029 | Values: 74.0 70.0 69.0 71.0 71.0 69.0 70.0 70.0 68.0 68.0 07:24:17 INFO - PROCESS | 21029 | -------- Summary: end -------- 07:24:17 INFO - PROCESS | 21029 | 07:24:18 INFO - TEST-INFO | 21029: exit 0 07:24:18 INFO - TEST-OK | kraken | took 64191ms 07:24:18 INFO - SUITE-END | took 1183s 07:24:18 INFO - Completed test suite (00:19:43) 07:24:18 INFO - javascript benchmark 07:24:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6197.81674331357, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.715571287158, 2588.4564241509283, 2594.1439325022743, 2618.1360151150116, 2622.6066090086474, 4696.342512048316, 4771.976140119299, 4790.065937142254, 4811.9654274331015, 4815.807367705288, 4692.319613656026, 4722.763861806913, 4772.451168115667, 4810.783514741836, 4813.66304358695, 4320.0, 4348.478182618082, 4393.736375817445, 4431.224535706238, 4483.910321793563, 4348.934765978513, 4446.7554284514335, 4463.062756821071, 4472.508024117361, 4500.414946057024, 4246.363045543162, 4272.807723652412, 4376.6936314458, 4382.758948257844, 4416.447944006999, 4286.0, 4289.549597292302, 4308.74147551148, 4314.02934339771, 4330.437043184366, 4278.529361770203, 4287.742735435884, 4293.892652683708, 4311.676624253194, 4313.223619748444, 4669.299605059235, 4726.291056341542, 4759.952400475986, 4770.689905156189, 4842.346283251751, 5131.948680513185, 5138.897222055575, 5146.459621739701, 5151.948480515184, 5179.637425380225, 5155.9742201288755, 5165.509276618715, 5174.534291913708, 5175.818846340398, 5177.119889618773, 4634.930476042829, 4672.509386514435, 4775.21209000511, 4801.399825021872, 4841.8547443576745, 5268.157094864803, 5306.52241298285, 5310.070737620901, 5341.893162136813, 5369.463053694677, 5037.420696619863, 5068.82259120929, 5089.083964886282, 5104.566111880532, 5131.050755610224, 4889.975550122226, 4969.552740253394, 5173.249878767558, 5179.922301165486, 5187.247849061865, 4961.578265847371, 4992.2511623256805, 5000.4999500050435, 5047.722375269395, 5096.311997880312, 5045.369328833895, 5068.315777370081, 5071.594272458195, 5072.594192464594, 5084.13569693153, 4239.04621460169, 4262.509811371732, 4268.231718290675, 4270.957290427118, 4301.075268817157, 3634.2186429917697, 3637.8726744563814, 3662.1943172502006, 3688.5942546319884, 3699.3711069118312, 4423.51341352451, 4424.513303536608, 4430.623397011225, 4440.755758433253, 4461.486929003207, 5073.898522029539, 5097.413797413271, 5128.794848206105, 5151.0470562945975, 5152.5362717354865, 4292.48490181174, 4314.633256173198, 4317.827286908551, 4359.237133501624, 4435.379046933432, 4484.8430304939175, 4497.415336006364, 4505.662075344362, 4511.571400716926, 4513.435820522434, 4676.251799712098, 4707.270373092108, 4711.104890070876, 4714.434267887876, 4714.905701886011, 5023.924641130459, 5037.19404895215, 5048.167052436307, 5050.090983622983, 5052.216906379517, 4649.418822647169, 4674.766261686834, 4687.015726697432, 4709.2936059589965, 4724.551167639069, 4959.107360675113, 4976.0794253063295, 4978.502149784992, 4986.177280748636, 4986.900261994812, 5012.147934851157, 5070.4929507049, 5079.390473143247, 5083.186690129562, 5131.589472842089, 4923.606111511142, 4955.851324460272, 4983.227599722049, 4987.326710893983, 5039.874003149951, 5001.924971125363, 5002.374703162105, 5003.149464590955, 5004.099262132851, 5052.242163675478, 4667.206574882346, 4774.880627984328, 4837.782299796448, 4851.805927762991, 4883.95116048835, 5024.472430394756, 5033.194688849767, 5052.671576347672, 5077.416097148875, 5088.643794934319, 4849.078675051729, 4920.926186107283, 4924.236743304794, 4932.186189278729, 4968.677035992793], "value": 4659.458042727968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.8873642166934, 531.3066448284986, 531.6145794299133, 537.2371232849355, 539.9109146990746, 39841.4023789643, 41383.0, 41469.58530414699, 44619.553804461946, 44818.0, 41010.58989410105, 41677.37483937744, 41683.58316416843, 41719.791401043025, 41869.0, 7551.773446796591, 7700.0, 7709.267619576131, 7713.34436572892, 9419.952900235523, 9348.719538413825, 9503.334766566342, 9570.665026724066, 9673.129418352348, 9675.322727409084, 9615.471149086798, 9620.230381569458, 9662.468564228964, 9663.130318271355, 9671.468069256189, 9414.388064775767, 9442.905570944271, 9445.386049906734, 9468.715938521855, 9489.0, 9575.760605984906, 9656.130948214695, 9657.130858222723, 9663.46850923206, 9663.758406039835, 33908.32183356344, 34290.82854585736, 34293.142671433416, 34335.31329373398, 34403.13992150191, 3504.6144924058335, 3578.4095624221973, 3587.3004764071015, 3613.313470440608, 3658.7255955803157, 25957.61063584029, 26103.477930441284, 26199.214023579323, 26640.20079397621, 27467.45065098687, 3353.2958078803235, 3373.9156521086925, 3392.0, 3436.879709210166, 3437.2438063625964, 155273.0, 155630.0, 155873.0, 156139.99999999886, 156335.2183239088, 46700.53299466962, 46969.53030469651, 47075.05849882983, 47142.764286178346, 47245.76377118092, 49213.75393123083, 49281.26078108831, 49372.3472861707, 49522.50477495251, 49645.25532117021, 13699.726005479835, 13853.445862165401, 13868.930655346861, 13876.444942202199, 13930.791038134435, 9651.90348096524, 9731.9026809731, 10223.233257505717, 10581.047705706369, 10782.892171078189, 15574.688506229812, 15637.452689155825, 15683.686326273411, 15711.292991815395, 15817.446389376317, 6410.455111315498, 6435.485161187187, 6501.9674901625185, 6532.216134063943, 6540.640264785482, 747.5141158247183, 773.9126527229251, 780.3211206250598, 781.2851241114316, 784.4548039112761, 24924.37689057788, 26392.472150557267, 26524.46951060968, 26812.195634130618, 26977.0, 935.1116439382614, 959.2661613865398, 967.6081187119228, 981.676046904534, 986.7582442301539, 13724.93137534306, 14271.357788899317, 14468.493602723855, 14498.420063197354, 14545.709085818437, 367721.0, 370448.0, 370915.0, 373132.0, 373588.0, 51146.74426627843, 51238.0, 51455.74272128615, 51678.48321516737, 51771.0, 1179.336232860321, 1210.2375503432957, 1210.6126039667397, 1227.2697744841805, 1227.9877201228053, 25324.873375633004, 26420.867895660398, 27095.86452067727, 27463.313417163932, 27703.168904932885, 41630.79184604058, 42390.99999999876, 42543.57456425396, 42584.361234582124, 42595.57404425916, 245030.0, 246030.0, 246039.0, 247108.0, 247268.0, 22570.322890313317, 22900.885495573082, 25061.49877002486, 25245.495090098462, 25457.363565911, 38788.61211387963, 40800.38799417952, 41076.589234107276, 41429.58570414378, 42110.0, 35249.295014100084, 35595.28809423849, 36617.267654647294, 37316.440253396766, 37408.81295593505, 35703.64296357003, 36111.0, 36202.0, 36202.4569631461, 36426.8178659105, 33421.16447088842, 33888.322233555686, 33904.83047584746, 34709.8264508686, 34794.0, 29626.555601666423, 32269.838650806596, 32351.0, 32412.675873240965, 32423.837880810446, 23803.40491487727, 24162.550246985236, 24649.0, 24699.0, 25142.49715005726], "value": 17073.204551812123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.37831902575357, 353.90975301298164, 356.43505044504457, 356.86617518430586, 366.8312576214941, 15457.922710386447, 15879.68240635188, 16342.182890855469, 16361.427350042752, 16394.016359018467, 14780.187089710089, 15647.765283520728, 16208.675826483463, 16342.673146537061, 16372.0, 4940.827071052514, 4946.9752651236695, 5081.263216833576, 5102.489751024887, 5117.488251174871, 4947.703137811743, 4997.425296090942, 5029.245613158019, 5032.5470707636305, 5057.0, 4996.7001979881325, 5020.497950204968, 5027.924581131268, 5271.262023316739, 5281.70950597717, 5282.102042652739, 5317.5480084192695, 5334.893302133974, 5349.919751203735, 5369.355677318707, 5074.391073071218, 5207.765650545697, 5208.114620514521, 5242.97378513105, 5245.160774276135, 11220.831687524693, 11366.37484938328, 11403.486843092081, 11407.48666310018, 18036.188371523313, 2075.6056349293585, 2085.7914208579173, 2176.3906106290265, 2187.9343619691435, 2252.31304452142, 8310.127436619128, 8711.346649001287, 8926.955365223132, 11784.823227651592, 12572.182808117443, 1636.8444997725196, 1701.8638508919257, 1713.4431309824356, 1729.541671457065, 1773.911304434773, 57688.71155644195, 58942.11586826201, 67661.32338676599, 67901.32098679, 68929.0, 8100.189981001853, 8217.465864718773, 8505.659773608986, 8712.869306960401, 8719.782005449788, 11076.833847492295, 11079.944600277107, 11154.721131971603, 11155.330680159217, 11180.888191118147, 6296.685165741695, 6751.594904305757, 6807.0, 6897.310049080863, 6963.338482844122, 6487.156669632917, 7023.0, 7031.191412987469, 7111.53775004623, 7192.136943566806, 3531.752777305564, 3586.3903136466865, 3588.69496092835, 3599.820008999592, 3636.090977255686, 1688.265604462063, 1728.9654206916043, 1760.779902512186, 1771.539399756047, 1791.435697755203, 791.7545560876147, 792.1247022040677, 801.703369753195, 802.7631848604676, 804.798800299925, 15217.467388641344, 15628.765568516481, 16062.43781467643, 16119.194040297938, 16138.75791863123, 930.9162175404247, 933.0343094896749, 936.896941336466, 944.5985456181232, 956.7420886707365, 8708.17272359125, 8735.694250701195, 9041.0, 9144.908550914539, 9188.127127922837, 270615.0, 274078.0, 366319.0, 371688.0, 372109.0, 54813.0, 54909.450905491234, 55343.72328138333, 55745.442545574835, 69044.30955690479, 913.2100732866156, 946.8295706772985, 957.593022965237, 959.2326139088701, 966.0, 14918.77621835695, 14970.176640284453, 15034.17312047848, 15338.386464541294, 15631.687366252838, 28476.85761571262, 33947.66052339445, 34634.307313854086, 34742.305153896275, 35618.10954726153, 49164.75417622889, 49959.75020124876, 49993.50006499889, 50157.0, 51943.0, 7010.929890701028, 7021.894671580033, 7082.3979961703835, 7317.085364329459, 7594.0, 8079.636416361161, 10320.48397580103, 11004.229703920648, 11183.776324473627, 11601.535938562363, 9373.250139988648, 9431.717048488556, 9643.357235756874, 10135.290529662852, 10180.389176649425, 9079.909200907907, 9216.170544651013, 9852.359596626196, 10129.290949633454, 10872.07587355052, 9874.901250987397, 9909.306348555532, 9925.305228633926, 10419.270651054354, 10636.89363106359, 7096.929030709627, 7334.3032411920785, 7426.554406735397, 7452.552846829208, 7674.8081297968, 9811.509424528887, 10282.383057016603, 10295.94852025735, 10459.110975567162, 10758.569657213624], "value": 7683.856720131039, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.1916040795318, 1336.939837707303, 1343.0464370297088, 1343.3216225805966, 1356.9389377478014, 6315.873682526347, 6562.770303039395, 6760.830979225516, 7136.072310599621, 7142.500024998246, 6860.622665753382, 6983.0, 7024.648767561627, 7201.0, 7262.128544574645, 2083.395815213586, 2115.206797450956, 2119.067610251492, 2124.2671278408925, 2125.278524395237, 2058.752949646037, 2101.95796084079, 2107.557412943284, 2112.2818241797786, 2165.9566808663817, 2059.9485012874648, 2061.402193363923, 2075.335892514396, 2087.759907610629, 2089.7387826521685, 2024.2409096588779, 2025.7265269188692, 2027.8174964253287, 2048.7541495020546, 2060.258307009475, 2097.2030628361276, 2104.4318034130697, 2121.31057406342, 2137.5938571671486, 2140.646793279107, 7221.8555628887125, 7239.420846332281, 7241.746538871167, 7247.20280769115, 7257.092863392076, 4365.323374876899, 4484.349769283435, 4495.955040449587, 4510.977445112786, 4515.525869783658, 2724.0820340072282, 2787.2892412434903, 2828.9575656364964, 2866.856657167133, 2882.6396700412447, 1039.4283144270696, 1039.7036844499282, 1072.2440679321137, 1081.6268387406333, 1090.8091084060259, 9413.341066125375, 9450.0, 9473.100055494717, 9473.66842160528, 9529.428234305895, 3799.3731034379016, 3802.733808633369, 3832.6358995895903, 3854.807259637007, 3889.9027524311555, 7629.122650895218, 7665.118511371264, 7669.271419215165, 7671.232876712284, 7673.424493162924, 4312.202242585132, 4319.784010799447, 4320.783960801948, 4320.956790432118, 4325.567443255649, 3917.373220284741, 4000.119973605802, 4008.579099194543, 4024.1348110155873, 4027.859024934113, 3130.358276553301, 3151.16494129056, 3189.617245930503, 3222.065600975691, 3258.0714496368896, 886.3131073418024, 910.5492781073278, 944.3531181140941, 964.4358050540372, 969.2536746704998, 849.562475325208, 855.3029281135854, 869.2046777198918, 888.7156110044724, 890.5903284489208, 4738.431388233434, 4864.78108485119, 4881.755912204447, 4986.700797952134, 4987.850364489072, 838.8112674648278, 873.4802792338548, 875.8861348024716, 878.2052242720348, 880.221004411088, 3347.464405695077, 3441.2257242120822, 3493.179102910814, 3497.440409534462, 3548.1484443733316, 7830.138684744674, 8277.917220827714, 8608.48349099056, 8655.264302534355, 8664.046954834963, 7971.481853679608, 8270.958645206856, 8272.17278272168, 8277.751667449986, 8296.585170741439, 6662.700178491979, 6727.125473688389, 6774.45804335652, 6821.1814582250445, 6854.760083397057, 4913.705177689207, 4966.8758281043265, 4970.826021089245, 5078.187490001582, 5120.820771272987, 7856.84286314282, 7879.448438609472, 7885.172056934169, 7891.84216315682, 7920.801979950317, 7441.8139546511775, 7822.413319000984, 7835.37317014626, 7932.127465978853, 8039.1156972734125, 6095.329513753395, 6198.907016394848, 6201.751929922933, 6210.937890621217, 6223.626582405071, 6595.406413422815, 6643.634600097041, 6685.364890335411, 6695.531312808057, 6707.698153583003, 5867.9413205869105, 6053.243344581927, 6163.075538669056, 6223.595466294676, 6276.1213430118905, 5907.350191478848, 5953.0, 5955.493783028491, 5959.612625179349, 5986.221791167294, 5310.230016647642, 5380.354357476971, 5390.434004429479, 5403.945960540502, 5418.403975562764, 4043.2115737432096, 4069.2268468990796, 4101.159262351271, 4273.850415235452, 4362.127574485052, 4171.520275168273, 4224.725392849455, 4241.703080784316, 4260.126674031878, 4274.95725042758], "value": 3825.6938886776998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.678722883502, 326.33264973129945, 330.0445211113825, 331.05318788265555, 334.51662347907285, 4819.518048195178, 4964.205727083668, 5042.924356134661, 5047.343845300111, 5084.44071152173, 4835.903281934368, 4913.459519452857, 4926.029588164736, 4958.3885237297845, 4965.939135258872, 3776.9055773605605, 3782.1301100746846, 3786.75386099904, 3797.810109494528, 3812.1613245086037, 3814.1227517670955, 3822.4710115953562, 3830.751001184914, 3831.731778775487, 3847.8845634631007, 3651.379265524867, 3739.813009349535, 3775.924481510368, 3801.5248093988253, 3821.522309711286, 3764.9623503764888, 3777.5466943966626, 3778.5465744110884, 3789.1663833956486, 3792.7950881505085, 3292.983535082333, 3322.684344987222, 3329.167708072982, 3329.267561136546, 3347.397468455677, 4739.976300118512, 4798.592119669797, 4915.877103072416, 4919.065377578248, 4935.555799977983, 4297.58179800665, 4323.3947247385395, 4334.198173337911, 4347.391365208873, 4358.193734159159, 5193.844184674465, 5197.896042079137, 5199.558037566811, 5221.650257384154, 5246.449122842085, 3621.692156166729, 3648.3068217038676, 3653.3058718843336, 3653.799041052741, 3658.6890114340313, 5199.766010529535, 5384.7846086156505, 5455.781768729246, 5487.64330318528, 5492.642978206404, 3683.342495876866, 3697.9815100924325, 3707.258548290353, 3718.200586873835, 3734.9066273343383, 3743.996961625517, 3752.45589389537, 3756.718246131551, 3768.8680896168503, 3779.7921114338424, 4128.422020917074, 4302.0, 4324.740515569076, 4325.567443255649, 4352.934705979413, 5237.240600113038, 5241.42344342122, 5259.737013149327, 5265.552428043583, 5290.285811415487, 1235.8516977962702, 1243.111175509515, 1252.642996745923, 1258.7104965857905, 1273.0, 821.6877586517205, 847.5423271433481, 847.6948298612494, 855.085058986878, 856.6892654239024, 4378.693491455568, 4380.255356589388, 4396.736195828261, 4409.33859921008, 4425.247707889666, 5206.557442617344, 5213.7393130343335, 5216.7913283469, 5218.373795144607, 5242.1914439518305, 4458.302726850209, 4462.527365969222, 4483.618892394118, 4496.325551167286, 4500.054988452396, 2654.230273220783, 2747.986260068687, 2768.076187050021, 2773.320536468578, 2797.384575393451, 4771.5228477152, 4774.976125119421, 4778.235482322812, 4795.544423279783, 4833.453294945654, 5107.719075450886, 5290.894182116336, 5316.46835316473, 5328.6802791832615, 5349.956758432068, 4809.5430934061205, 4838.758062096951, 4855.927161092586, 4868.02639472107, 4898.804047838118, 5139.92290115656, 5157.174852023658, 5168.53483186515, 5228.294180285613, 5231.712255825966, 5007.122329126578, 5087.847364579068, 5110.565601923878, 5131.640785145004, 5145.404924473425, 4761.523847615211, 4817.9518204818905, 4820.517948205152, 4825.300331451849, 4834.540718631724, 3561.4479755637917, 3571.303595798898, 3580.0691820126435, 3584.6773790358993, 3597.9820100900374, 4906.828261010847, 5160.767765450489, 5164.845054648366, 5186.377634683862, 5187.870303242449, 5051.974740126276, 5073.365829271341, 5075.705695047739, 5077.92383114261, 5122.334096567422, 4928.236123400879, 4968.0, 5073.213651883964, 5085.847424577269, 5089.236614507853, 4861.829835955725, 4883.633727470383, 4980.211081794207, 5021.698698078127, 5024.71869673231, 5223.686578805284, 5272.472752724697, 5272.497338258578, 5285.229448134918, 5296.496832800878, 5139.254808052737, 5141.5629671476845, 5164.431912489548, 5166.793328266827, 5213.348331458567], "value": 3842.649923778132, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.895153313551, 657.9934200657989, 722.7542635503929, 723.2803360656148, 750.3134631811893, 12088.516459341627, 13419.261940593264, 13645.727085458286, 13658.38537265823, 13674.384652690627, 12479.937600311985, 12496.56262030829, 12649.17780344277, 12689.428975696093, 12833.871661283385, 660.1253339325389, 674.8650269946006, 777.8522080804657, 779.6959185917497, 799.2087833045273, 793.6983946100473, 810.8297257575887, 813.4875028731891, 816.7263966571206, 817.3216230528647, 855.3798496090347, 856.7686724584358, 857.8327226190895, 861.5907443964098, 862.0991064337751, 835.9832803343929, 844.269706703703, 849.371465115816, 855.8416692911832, 860.7116615933638, 625.1341891480287, 625.1778910732372, 626.7399029402792, 626.8088233088906, 628.3339659960457, 13170.407331670098, 13241.801372979413, 13427.66430839227, 13473.326333683277, 14019.228942408163, 13737.313134343343, 14280.785788213185, 14382.640433989129, 14519.70960580793, 14635.268236588234, 10612.151027917747, 10710.0, 10716.892831071746, 10757.892421075767, 10770.4614769262, 3259.494778309342, 3330.184104894292, 3377.7973321600784, 3379.8141102239365, 3465.740069494798, 68335.0, 68380.6580967092, 68459.3154068458, 69443.0, 70499.0, 9697.175740062032, 9732.854007189897, 9936.205103591696, 10234.232432567587, 11071.280366776135, 16529.752053719203, 16735.91632041832, 16785.66428671444, 16808.411705590246, 16824.0, 6291.087792270096, 6409.647469389229, 6524.6737663116655, 6558.770443034471, 6621.4040736333, 3581.982090089533, 3606.13452771333, 3622.239329740731, 3642.9817850910576, 3666.871659491905, 2950.9409811803644, 2953.9556906646417, 2968.0650595062916, 2975.821450712921, 3004.4291584598855, 490.8110377504615, 491.09883364026695, 498.48904872505244, 500.6395395315367, 505.2875445621656, 624.6283461340495, 627.5826575327447, 640.2828831708516, 647.6017249391684, 654.8115170964684, 8232.094469608339, 8295.668173273001, 8422.452540584965, 8586.430046053641, 8887.200151986352, 606.8634557224677, 614.1647359590953, 633.9302676705558, 634.6731433311849, 634.7968650031945, 4033.9925248381937, 4170.708050436501, 4245.787710614457, 4276.1661476012505, 4297.312430011183, 66749.0, 68547.31452685509, 69747.65126174336, 70821.64589177124, 71421.0, 58493.0, 59579.0, 59916.0, 62687.6865615669, 63370.36629633737, 54084.0, 54444.0, 54643.0, 54930.45069549333, 55167.448325516234, 7764.84470310602, 8076.515409075474, 8110.675572977015, 8210.425270231266, 8274.710385136492, 37213.25573488569, 37445.625543744216, 37960.62039379571, 39139.6086039136, 39465.60534394734, 46357.0, 47188.76405618087, 47278.81802954953, 47395.52604473911, 48543.757281213366, 9386.906130938876, 9447.480388578419, 9509.667161649586, 9656.130948214695, 9732.61069557238, 10845.891541084804, 10875.836862446911, 11089.778204436028, 11239.100871930063, 11273.436328183394, 10327.535260913428, 10554.894451055392, 10593.470326483799, 10736.141108711441, 10876.12990960737, 10483.947580262049, 10501.527431265458, 10713.303635263683, 10828.18788590843, 10944.507497162806, 11632.360220187971, 11883.940580297389, 11902.464389102684, 11983.820242696193, 12056.0, 9481.715548533555, 9714.562844671866, 10050.89949100529, 10070.69787906364, 10355.17158627323, 9293.953530232306, 9953.950230248802, 10023.448710321003, 10131.240156988108, 10295.588176472857], "value": 6306.835788580164, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 115.0, 116.0, 115.0, 117.0, 116.0, 116.0, 115.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 129.0, 176.0, 129.0, 130.0, 132.0, 130.0, 150.0, 134.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 166.0, 172.0, 164.0, 163.0, 164.0, 164.0, 163.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 113.0, 77.0, 77.0, 76.0, 77.0, 106.0, 78.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 85.0, 85.0, 85.0, 98.0, 85.0, 86.0, 115.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 119.0, 118.0, 117.0, 120.0, 118.0, 119.0, 119.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 151.0, 150.0, 152.0, 151.0, 151.0, 150.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 95.0, 96.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 74.0, 69.0, 68.0, 69.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 73.0, 68.0, 66.0, 67.0, 71.0, 68.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 91.0, 86.0, 85.0, 86.0, 85.0, 84.0, 86.0, 87.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 147.0, 142.0, 142.0, 137.0, 135.0, 144.0, 155.0, 220.0, 137.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 176.0, 183.0, 178.0, 183.0, 181.0, 178.0, 176.0, 177.0, 179.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 69.0, 71.0, 71.0, 69.0, 70.0, 70.0, 68.0, 68.0], "value": 70.0, "unit": "score"}]}]} 07:24:18 INFO - Return code: 0 07:24:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:24:18 ERROR - # TBPL SUCCESS # 07:24:18 INFO - Running post-action listener: _resource_record_post_action 07:24:18 INFO - [mozharness: 2017-01-04 15:24:18.904691Z] Finished run-tests step (success) 07:24:18 INFO - Running post-run listener: _resource_record_post_run 07:24:18 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 4096; Write bytes: 411627520; Read time: 20; Write time: 277228 07:24:18 INFO - TinderboxPrint: CPU usage
13.6% 07:24:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 07:24:18 INFO - TinderboxPrint: I/O write bytes / time
411,627,520 / 277,228 07:24:18 INFO - TinderboxPrint: CPU idle
8,275.3 (86.4%) 07:24:18 INFO - TinderboxPrint: CPU user
1,238.4 (12.9%) 07:24:18 INFO - TinderboxPrint: Swap in / out
0 / 0 07:24:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115834880; Read time: 0; Write time: 111748 07:24:18 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 294842368; Read time: 0; Write time: 165460 07:24:19 INFO - Running post-run listener: _upload_blobber_files 07:24:19 INFO - Blob upload gear active. 07:24:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:24:19 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 07:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:24:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:24:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:24:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:24:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:20 INFO - (blobuploader) - INFO - Done attempting. 07:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:24:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:21 INFO - (blobuploader) - INFO - Done attempting. 07:24:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:24:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:25 INFO - (blobuploader) - INFO - Done attempting. 07:24:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:24:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:24:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:26 INFO - (blobuploader) - INFO - Done attempting. 07:24:26 INFO - (blobuploader) - INFO - Iteration through files over. 07:24:26 INFO - Return code: 0 07:24:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:24:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:24:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a2f4c745add6a033eaa4310f158f3fd58d927defc318852970fe926c4f2a0049077e5fefc175481d029830fbb72c672f70caf01e320f66448610418c333d796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9887ae28f95edf28889f09f7b939a0e4745dfa0a564c18100bfbc12cb7fa810a74f7dff94253a69421ec4fa864bbb5c2d7599abefaeda135bbd82e816b8c05d5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94fb56a5455c14f4307a04db73efd7db162dc3bd6b8e2d75c4583d30eaa986be2f0d47bc6012550276acfb1e6dd36ca9989f71c24e5d4d7a41eb2298d3853ea0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1077b736e06cd11fffda2580c3e2115f4bc8f6d194c978b3d8d3cb82fdc516effe6b38fe8e0a69a09886c8ed24c2da10e28de6b9839af55b0f27379ddb4f1f31"} 07:24:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:24:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:24:26 INFO - Contents: 07:24:26 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a2f4c745add6a033eaa4310f158f3fd58d927defc318852970fe926c4f2a0049077e5fefc175481d029830fbb72c672f70caf01e320f66448610418c333d796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9887ae28f95edf28889f09f7b939a0e4745dfa0a564c18100bfbc12cb7fa810a74f7dff94253a69421ec4fa864bbb5c2d7599abefaeda135bbd82e816b8c05d5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94fb56a5455c14f4307a04db73efd7db162dc3bd6b8e2d75c4583d30eaa986be2f0d47bc6012550276acfb1e6dd36ca9989f71c24e5d4d7a41eb2298d3853ea0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1077b736e06cd11fffda2580c3e2115f4bc8f6d194c978b3d8d3cb82fdc516effe6b38fe8e0a69a09886c8ed24c2da10e28de6b9839af55b0f27379ddb4f1f31"} 07:24:26 INFO - Running post-run listener: copy_logs_to_upload_dir 07:24:26 INFO - Copying logs to upload dir... 07:24:26 INFO - mkdir: /builds/slave/test/build/upload/logs 07:24:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.035638 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-04 07:24:24.532640) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 07:24:24.535825) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a2f4c745add6a033eaa4310f158f3fd58d927defc318852970fe926c4f2a0049077e5fefc175481d029830fbb72c672f70caf01e320f66448610418c333d796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9887ae28f95edf28889f09f7b939a0e4745dfa0a564c18100bfbc12cb7fa810a74f7dff94253a69421ec4fa864bbb5c2d7599abefaeda135bbd82e816b8c05d5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94fb56a5455c14f4307a04db73efd7db162dc3bd6b8e2d75c4583d30eaa986be2f0d47bc6012550276acfb1e6dd36ca9989f71c24e5d4d7a41eb2298d3853ea0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1077b736e06cd11fffda2580c3e2115f4bc8f6d194c978b3d8d3cb82fdc516effe6b38fe8e0a69a09886c8ed24c2da10e28de6b9839af55b0f27379ddb4f1f31"} build_url:https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/SgwOvsZVSeuLniXBIdkpwQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a2f4c745add6a033eaa4310f158f3fd58d927defc318852970fe926c4f2a0049077e5fefc175481d029830fbb72c672f70caf01e320f66448610418c333d796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9887ae28f95edf28889f09f7b939a0e4745dfa0a564c18100bfbc12cb7fa810a74f7dff94253a69421ec4fa864bbb5c2d7599abefaeda135bbd82e816b8c05d5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94fb56a5455c14f4307a04db73efd7db162dc3bd6b8e2d75c4583d30eaa986be2f0d47bc6012550276acfb1e6dd36ca9989f71c24e5d4d7a41eb2298d3853ea0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1077b736e06cd11fffda2580c3e2115f4bc8f6d194c978b3d8d3cb82fdc516effe6b38fe8e0a69a09886c8ed24c2da10e28de6b9839af55b0f27379ddb4f1f31"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 07:24:24.561110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:24:24.561418) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483541763.43523-1249559420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:24:24.644053) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 07:24:24.644349) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 07:24:24.644628) ========= ========= Total master_lag: 0.15 =========