builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1487956051.94 results: success (0) revision: 4851173666d03c2be1e2d72705650c69cfc35dfb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:31.935643) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:31.936371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:31.936870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:31.954692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:31.955086) ========= 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=3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-24 09:07:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2017-02-24 09:07:32 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114393 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:32.083692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:32.084141) ========= 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=3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014675 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:32.135904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-24 09:07:32.136465) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4851173666d03c2be1e2d72705650c69cfc35dfb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4851173666d03c2be1e2d72705650c69cfc35dfb --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=3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-24 09:07:32,568 truncating revision to first 12 chars 2017-02-24 09:07:32,568 Setting DEBUG logging. 2017-02-24 09:07:32,568 attempt 1/10 2017-02-24 09:07:32,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4851173666d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-24 09:07:33,825 unpacking tar archive at: mozilla-aurora-4851173666d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.558570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-24 09:07:33.708508) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:33.708858) ========= script_repo_revision: 4851173666d03c2be1e2d72705650c69cfc35dfb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:33.709236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:33.709502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 09:07:33.722616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-02-24 09:07:33.723013) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:34 INFO - MultiFileLogger online at 20170224 09:07:34 in /builds/slave/test 09:07:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:07:34 INFO - {'append_to_log': False, 09:07:34 INFO - 'base_work_dir': '/builds/slave/test', 09:07:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:07:34 INFO - 'branch': 'Mozilla-Aurora', 09:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:34 INFO - 'config_files': ('talos/linux_config.py',), 09:07:34 INFO - 'default_actions': ('clobber', 09:07:34 INFO - 'read-buildbot-config', 09:07:34 INFO - 'download-and-extract', 09:07:34 INFO - 'populate-webroot', 09:07:34 INFO - 'create-virtualenv', 09:07:34 INFO - 'install', 09:07:34 INFO - 'run-tests'), 09:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:34 INFO - 'download_minidump_stackwalk': True, 09:07:34 INFO - 'download_symbols': 'ondemand', 09:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:34 INFO - 'installer_path': 'installer.exe', 09:07:34 INFO - 'log_level': 'info', 09:07:34 INFO - 'log_name': 'talos', 09:07:34 INFO - 'log_to_console': True, 09:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:34 INFO - 'opt_config_files': (), 09:07:34 INFO - 'pip_index': False, 09:07:34 INFO - 'sps_profile': False, 09:07:34 INFO - 'sps_profile_interval': 0, 09:07:34 INFO - 'suite': 'dromaeojs', 09:07:34 INFO - 'system_bits': '32', 09:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:34 INFO - 'title': 'talos-linux64-ix-030', 09:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:34 INFO - 'use_talos_json': True, 09:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:34 INFO - 'work_dir': 'build'} 09:07:34 INFO - [mozharness: 2017-02-24 17:07:34.253951Z] Running clobber step. 09:07:34 INFO - Running pre-action listener: _resource_record_pre_action 09:07:34 INFO - Running main action method: clobber 09:07:34 INFO - rmtree: /builds/slave/test/build 09:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:07:34 INFO - Running post-action listener: _resource_record_post_action 09:07:34 INFO - [mozharness: 2017-02-24 17:07:34.714349Z] Finished clobber step (success) 09:07:34 INFO - [mozharness: 2017-02-24 17:07:34.714450Z] Running read-buildbot-config step. 09:07:34 INFO - Running pre-action listener: _resource_record_pre_action 09:07:34 INFO - Running main action method: read_buildbot_config 09:07:34 INFO - Using buildbot properties: 09:07:34 INFO - { 09:07:34 INFO - "project": "", 09:07:34 INFO - "product": "firefox", 09:07:34 INFO - "who": "ffxbld@noreply.mozilla.org", 09:07:34 INFO - "installer_path": "public/build/target.tar.bz2", 09:07:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:07:34 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:07:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:07:34 INFO - "stage_platform": "linux64-pgo", 09:07:34 INFO - "basedir": "/builds/slave/test", 09:07:34 INFO - "buildnumber": 1078, 09:07:34 INFO - "platform": "ubuntu64_hw", 09:07:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:07:34 INFO - "slavebuilddir": "test", 09:07:34 INFO - "taskId": "bAG1XnakQXuhD2jK8bQoeg", 09:07:34 INFO - "branch": "mozilla-aurora", 09:07:34 INFO - "script_repo_revision": "production", 09:07:34 INFO - "revision": "4851173666d03c2be1e2d72705650c69cfc35dfb", 09:07:34 INFO - "slavename": "talos-linux64-ix-030", 09:07:34 INFO - "repo_path": "releases/mozilla-aurora" 09:07:34 INFO - } 09:07:34 INFO - Finding installer, test and symbols from parent task. 09:07:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bAG1XnakQXuhD2jK8bQoeg'}, attempt #1 09:07:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bAG1XnakQXuhD2jK8bQoeg'}, attempt #1 09:07:35 INFO - Task dependencies: M4WFLnrZSEigZuaIJJll8w 09:07:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w'}, attempt #1 09:07:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.tar.bz2 09:07:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/test_packages.json 09:07:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.crashreporter-symbols.zip 09:07:36 INFO - Running post-action listener: _resource_record_post_action 09:07:36 INFO - [mozharness: 2017-02-24 17:07:36.188012Z] Finished read-buildbot-config step (success) 09:07:36 INFO - [mozharness: 2017-02-24 17:07:36.188230Z] Running download-and-extract step. 09:07:36 INFO - Running pre-action listener: _resource_record_pre_action 09:07:36 INFO - Running main action method: download_and_extract 09:07:36 INFO - mkdir: /builds/slave/test/build/tests 09:07:36 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')]} 09:07:36 INFO - trying https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.test_packages.json 09:07:36 INFO - Downloading https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:07:36 INFO - Downloaded 896 bytes. 09:07:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:07:36 INFO - Using the following test package requirements: 09:07:36 INFO - {u'common': [u'target.common.tests.zip'], 09:07:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:07:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:07:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:07:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:07:36 INFO - u'mozbase': [u'target.common.tests.zip'], 09:07:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:07:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:07:36 INFO - u'web-platform': [u'target.common.tests.zip', 09:07:36 INFO - u'target.web-platform.tests.zip'], 09:07:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:07:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:07:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.common.tests.zip 09:07:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:07:36 INFO - Fetch https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.common.tests.zip into memory 09:07:39 INFO - Expected file size: 21860242 09:07:39 INFO - Obtained file size: 21860242 09:07:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:07:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.common.tests.zip 09:07:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:07:43 INFO - Fetch https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.common.tests.zip into memory 09:07:45 INFO - Expected file size: 21860242 09:07:45 INFO - Obtained file size: 21860242 09:07:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.talos.tests.zip 09:07:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:07:49 INFO - Fetch https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.talos.tests.zip into memory 09:07:51 INFO - Expected file size: 14403472 09:07:51 INFO - Obtained file size: 14403472 09:07:51 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')]} 09:07:51 INFO - trying https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.tar.bz2 09:07:51 INFO - Downloading https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:07:55 INFO - Downloaded 66108870 bytes. 09:07:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.tar.bz2 09:07:55 INFO - mkdir: /builds/slave/test/properties 09:07:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:55 INFO - Contents: 09:07:55 INFO - build_url:https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.tar.bz2 09:07:55 INFO - Running post-action listener: _resource_record_post_action 09:07:55 INFO - Running post-action listener: set_extra_try_arguments 09:07:55 INFO - [mozharness: 2017-02-24 17:07:55.918173Z] Finished download-and-extract step (success) 09:07:55 INFO - [mozharness: 2017-02-24 17:07:55.918290Z] Running populate-webroot step. 09:07:55 INFO - Running pre-action listener: _resource_record_pre_action 09:07:55 INFO - Running main action method: populate_webroot 09:07:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:55 INFO - '--tppagecycles', 09:07:55 INFO - '7'], 09:07:55 INFO - 'tests': ['tsvgm']}}, 09:07:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:07:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:07:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:07:55 INFO - 'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:07:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:07:55 INFO - 'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['damp', 'tps']}, 09:07:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:07:55 INFO - 'tests': ['damp', 'tps']}, 09:07:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['dromaeo_dom']}, 09:07:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['basic_compositor_video']}, 09:07:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:07:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['a11yr', 09:07:55 INFO - 'ts_paint', 09:07:55 INFO - 'tpaint', 09:07:55 INFO - 'sessionrestore', 09:07:55 INFO - 'sessionrestore_no_auto_restore', 09:07:55 INFO - 'tabpaint']}, 09:07:55 INFO - 'other-e10s': {'tests': ['a11yr', 09:07:55 INFO - 'ts_paint', 09:07:55 INFO - 'tpaint', 09:07:55 INFO - 'sessionrestore', 09:07:55 INFO - 'sessionrestore_no_auto_restore', 09:07:55 INFO - 'tabpaint']}, 09:07:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:07:55 INFO - 'ts_paint', 09:07:55 INFO - 'tpaint', 09:07:55 INFO - 'sessionrestore', 09:07:55 INFO - 'sessionrestore_no_auto_restore', 09:07:55 INFO - 'tabpaint']}, 09:07:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:07:55 INFO - 'ts_paint', 09:07:55 INFO - 'tpaint', 09:07:55 INFO - 'sessionrestore', 09:07:55 INFO - 'sessionrestore_no_auto_restore', 09:07:55 INFO - 'tabpaint']}, 09:07:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['a11yr', 09:07:55 INFO - 'ts_paint', 09:07:55 INFO - 'tpaint', 09:07:55 INFO - 'sessionrestore', 09:07:55 INFO - 'sessionrestore_no_auto_restore', 09:07:55 INFO - 'tabpaint']}, 09:07:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['a11yr', 09:07:55 INFO - 'ts_paint', 09:07:55 INFO - 'tpaint', 09:07:55 INFO - 'sessionrestore', 09:07:55 INFO - 'sessionrestore_no_auto_restore', 09:07:55 INFO - 'tabpaint']}, 09:07:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['tsvgx', 09:07:55 INFO - 'tsvgr_opacity', 09:07:55 INFO - 'tart', 09:07:55 INFO - 'tscrollx', 09:07:55 INFO - 'cart', 09:07:55 INFO - 'tsvg_static']}, 09:07:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:07:55 INFO - 'tsvgr_opacity', 09:07:55 INFO - 'tart', 09:07:55 INFO - 'tscrollx', 09:07:55 INFO - 'cart', 09:07:55 INFO - 'tsvg_static']}, 09:07:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:07:55 INFO - 'talos_options': ['--disable-e10s'], 09:07:55 INFO - 'tests': ['tp5o']}, 09:07:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:07:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:07:55 INFO - 'talos_options': ['--disable-e10s', 09:07:55 INFO - '--xperf_path', 09:07:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:55 INFO - 'tests': ['tp5n']}, 09:07:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:07:55 INFO - 'talos_options': ['--xperf_path', 09:07:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:55 INFO - 'tests': ['tp5n']}}, 09:07:55 INFO - 'talos.zip': {'path': '', 09:07:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:55 INFO - Running post-action listener: _resource_record_post_action 09:07:55 INFO - [mozharness: 2017-02-24 17:07:55.932044Z] Finished populate-webroot step (success) 09:07:55 INFO - [mozharness: 2017-02-24 17:07:55.932134Z] Running create-virtualenv step. 09:07:55 INFO - Running pre-action listener: _resource_record_pre_action 09:07:55 INFO - Running main action method: create_virtualenv 09:07:55 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07: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 09:07:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:56 INFO - Using real prefix '/usr' 09:07:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:56 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:58 INFO - Installing pip.................done. 09:07:58 INFO - Return code: 0 09:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:07:58 INFO - Reading from file tmpfile_stdout 09:07:58 INFO - Output received: 09:07: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) 09:07:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:07: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 09:07: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 09:07:58 INFO - Using env: {'DISPLAY': ':0', 09:07:58 INFO - 'HOME': '/home/cltbld', 09:07:58 INFO - 'LANG': 'en_US.UTF-8', 09:07:58 INFO - 'LANGUAGE': 'en_US:en', 09:07:58 INFO - 'LOGNAME': 'cltbld', 09:07:58 INFO - 'MAIL': '/var/mail/cltbld', 09:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:58 INFO - 'MOZ_NO_REMOTE': '1', 09:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:58 INFO - 'NO_EM_RESTART': '1', 09:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:58 INFO - 'PWD': '/builds/slave/test', 09:07:58 INFO - 'SHELL': '/bin/bash', 09:07:58 INFO - 'SHLVL': '1', 09:07:58 INFO - 'TERM': 'linux', 09:07:58 INFO - 'TMOUT': '86400', 09:07:58 INFO - 'USER': 'cltbld', 09:07:58 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:58 INFO - '_': '/tools/buildbot/bin/python'} 09:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07: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 09:07:58 INFO - Cleaning up... 09:07:58 INFO - Return code: 0 09:07:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:07: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 09:07: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 09:07:58 INFO - Using env: {'DISPLAY': ':0', 09:07:58 INFO - 'HOME': '/home/cltbld', 09:07:58 INFO - 'LANG': 'en_US.UTF-8', 09:07:58 INFO - 'LANGUAGE': 'en_US:en', 09:07:58 INFO - 'LOGNAME': 'cltbld', 09:07:58 INFO - 'MAIL': '/var/mail/cltbld', 09:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:58 INFO - 'MOZ_NO_REMOTE': '1', 09:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:58 INFO - 'NO_EM_RESTART': '1', 09:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:58 INFO - 'PWD': '/builds/slave/test', 09:07:58 INFO - 'SHELL': '/bin/bash', 09:07:58 INFO - 'SHLVL': '1', 09:07:58 INFO - 'TERM': 'linux', 09:07:58 INFO - 'TMOUT': '86400', 09:07:58 INFO - 'USER': 'cltbld', 09:07:58 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:58 INFO - '_': '/tools/buildbot/bin/python'} 09:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:59 INFO - Downloading/unpacking psutil>=3.1.1 09:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:01 INFO - Installing collected packages: psutil 09:08:01 INFO - Running setup.py install for psutil 09:08:01 INFO - building 'psutil._psutil_linux' extension 09:08:01 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 09:08: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 09:08:01 INFO - building 'psutil._psutil_posix' extension 09:08: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 09:08: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 09:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:01 INFO - Successfully installed psutil 09:08:01 INFO - Cleaning up... 09:08:01 INFO - Return code: 0 09:08:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:08: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 09:08: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 09:08:01 INFO - Using env: {'DISPLAY': ':0', 09:08:01 INFO - 'HOME': '/home/cltbld', 09:08:01 INFO - 'LANG': 'en_US.UTF-8', 09:08:01 INFO - 'LANGUAGE': 'en_US:en', 09:08:01 INFO - 'LOGNAME': 'cltbld', 09:08:01 INFO - 'MAIL': '/var/mail/cltbld', 09:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:01 INFO - 'MOZ_NO_REMOTE': '1', 09:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:01 INFO - 'NO_EM_RESTART': '1', 09:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:01 INFO - 'PWD': '/builds/slave/test', 09:08:01 INFO - 'SHELL': '/bin/bash', 09:08:01 INFO - 'SHLVL': '1', 09:08:01 INFO - 'TERM': 'linux', 09:08:01 INFO - 'TMOUT': '86400', 09:08:01 INFO - 'USER': 'cltbld', 09:08:01 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:01 INFO - '_': '/tools/buildbot/bin/python'} 09:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:08:02 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 09:08:02 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 09:08:02 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 09:08:02 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 09:08:02 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 09:08:02 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 09:08:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:08:04 INFO - Installing collected packages: mozsystemmonitor 09:08:04 INFO - Running setup.py install for mozsystemmonitor 09:08:04 INFO - Successfully installed mozsystemmonitor 09:08:04 INFO - Cleaning up... 09:08:04 INFO - Return code: 0 09:08:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:08:04 INFO - Using env: {'DISPLAY': ':0', 09:08:04 INFO - 'HOME': '/home/cltbld', 09:08:04 INFO - 'LANG': 'en_US.UTF-8', 09:08:04 INFO - 'LANGUAGE': 'en_US:en', 09:08:04 INFO - 'LOGNAME': 'cltbld', 09:08:04 INFO - 'MAIL': '/var/mail/cltbld', 09:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:04 INFO - 'MOZ_NO_REMOTE': '1', 09:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:04 INFO - 'NO_EM_RESTART': '1', 09:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:04 INFO - 'PWD': '/builds/slave/test', 09:08:04 INFO - 'SHELL': '/bin/bash', 09:08:04 INFO - 'SHLVL': '1', 09:08:04 INFO - 'TERM': 'linux', 09:08:04 INFO - 'TMOUT': '86400', 09:08:04 INFO - 'USER': 'cltbld', 09:08:04 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:04 INFO - '_': '/tools/buildbot/bin/python'} 09:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:04 INFO - Downloading/unpacking jsonschema==2.5.1 09:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:08:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:06 INFO - Downloading functools32-3.2.3-2.tar.gz 09:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:08:06 INFO - warning: no files found matching '*.txt' 09:08:06 INFO - no previously-included directories found matching 'build' 09:08:06 INFO - no previously-included directories found matching 'dist' 09:08:06 INFO - no previously-included directories found matching '.git*' 09:08:06 INFO - Installing collected packages: jsonschema, functools32 09:08:06 INFO - Running setup.py install for functools32 09:08:06 INFO - warning: no files found matching '*.txt' 09:08:06 INFO - no previously-included directories found matching 'build' 09:08:06 INFO - no previously-included directories found matching 'dist' 09:08:06 INFO - no previously-included directories found matching '.git*' 09:08:06 INFO - Successfully installed jsonschema functools32 09:08:06 INFO - Cleaning up... 09:08:06 INFO - Return code: 0 09:08:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:08:07 INFO - Using env: {'DISPLAY': ':0', 09:08:07 INFO - 'HOME': '/home/cltbld', 09:08:07 INFO - 'LANG': 'en_US.UTF-8', 09:08:07 INFO - 'LANGUAGE': 'en_US:en', 09:08:07 INFO - 'LOGNAME': 'cltbld', 09:08:07 INFO - 'MAIL': '/var/mail/cltbld', 09:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:07 INFO - 'MOZ_NO_REMOTE': '1', 09:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:07 INFO - 'NO_EM_RESTART': '1', 09:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:07 INFO - 'PWD': '/builds/slave/test', 09:08:07 INFO - 'SHELL': '/bin/bash', 09:08:07 INFO - 'SHLVL': '1', 09:08:07 INFO - 'TERM': 'linux', 09:08:07 INFO - 'TMOUT': '86400', 09:08:07 INFO - 'USER': 'cltbld', 09:08:07 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:07 INFO - '_': '/tools/buildbot/bin/python'} 09:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:08:07 INFO - Cleaning up... 09:08:07 INFO - Return code: 0 09:08:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:08:07 INFO - Using env: {'DISPLAY': ':0', 09:08:07 INFO - 'HOME': '/home/cltbld', 09:08:07 INFO - 'LANG': 'en_US.UTF-8', 09:08:07 INFO - 'LANGUAGE': 'en_US:en', 09:08:07 INFO - 'LOGNAME': 'cltbld', 09:08:07 INFO - 'MAIL': '/var/mail/cltbld', 09:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:07 INFO - 'MOZ_NO_REMOTE': '1', 09:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:07 INFO - 'NO_EM_RESTART': '1', 09:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:07 INFO - 'PWD': '/builds/slave/test', 09:08:07 INFO - 'SHELL': '/bin/bash', 09:08:07 INFO - 'SHLVL': '1', 09:08:07 INFO - 'TERM': 'linux', 09:08:07 INFO - 'TMOUT': '86400', 09:08:07 INFO - 'USER': 'cltbld', 09:08:07 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:07 INFO - '_': '/tools/buildbot/bin/python'} 09:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:07 INFO - Downloading/unpacking blobuploader==1.2.4 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:08:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:08:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:10 INFO - Downloading docopt-0.6.1.tar.gz 09:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:08:10 INFO - Installing collected packages: blobuploader, requests, docopt 09:08:10 INFO - Running setup.py install for blobuploader 09:08:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:08:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:08:10 INFO - Running setup.py install for requests 09:08:10 INFO - Running setup.py install for docopt 09:08:10 INFO - Successfully installed blobuploader requests docopt 09:08:10 INFO - Cleaning up... 09:08:10 INFO - Return code: 0 09:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08: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')]} 09:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:08: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 09:08: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 09:08:10 INFO - Using env: {'DISPLAY': ':0', 09:08:10 INFO - 'HOME': '/home/cltbld', 09:08:10 INFO - 'LANG': 'en_US.UTF-8', 09:08:10 INFO - 'LANGUAGE': 'en_US:en', 09:08:10 INFO - 'LOGNAME': 'cltbld', 09:08:10 INFO - 'MAIL': '/var/mail/cltbld', 09:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:10 INFO - 'MOZ_NO_REMOTE': '1', 09:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:10 INFO - 'NO_EM_RESTART': '1', 09:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:10 INFO - 'PWD': '/builds/slave/test', 09:08:10 INFO - 'SHELL': '/bin/bash', 09:08:10 INFO - 'SHLVL': '1', 09:08:10 INFO - 'TERM': 'linux', 09:08:10 INFO - 'TMOUT': '86400', 09:08:10 INFO - 'USER': 'cltbld', 09:08:10 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:10 INFO - '_': '/tools/buildbot/bin/python'} 09:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:11 INFO - Running setup.py (path:/tmp/pip-99MsFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:11 INFO - Running setup.py (path:/tmp/pip-qTds5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:11 INFO - Running setup.py (path:/tmp/pip-AyPGUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:11 INFO - Running setup.py (path:/tmp/pip-HV5D39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:11 INFO - Running setup.py (path:/tmp/pip-avPmY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:11 INFO - Running setup.py (path:/tmp/pip-MYquaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:11 INFO - Running setup.py (path:/tmp/pip-KlHq3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:11 INFO - Running setup.py (path:/tmp/pip-cxS4jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:11 INFO - Running setup.py (path:/tmp/pip-g9FmLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:11 INFO - Running setup.py (path:/tmp/pip-xNEX2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:11 INFO - Running setup.py (path:/tmp/pip-AgADdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:11 INFO - Running setup.py (path:/tmp/pip-l0lIWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:11 INFO - Running setup.py (path:/tmp/pip-fkT8Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:11 INFO - Running setup.py (path:/tmp/pip-9qwj9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:12 INFO - Running setup.py (path:/tmp/pip-I28E7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:12 INFO - Running setup.py (path:/tmp/pip-Lofg7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:12 INFO - Running setup.py (path:/tmp/pip-q3dWHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:08:12 INFO - Running setup.py install for manifestparser 09:08:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozcrash 09:08:12 INFO - Running setup.py install for mozdebug 09:08:12 INFO - Running setup.py install for mozdevice 09:08:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozfile 09:08:12 INFO - Running setup.py install for mozhttpd 09:08:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Running setup.py install for mozinfo 09:08:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozInstall 09:08:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozleak 09:08:13 INFO - Running setup.py install for mozlog 09:08:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for moznetwork 09:08:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozprocess 09:08:13 INFO - Running setup.py install for mozprofile 09:08:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozrunner 09:08:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:08:13 INFO - Running setup.py install for mozscreenshot 09:08:13 INFO - Running setup.py install for moztest 09:08:14 INFO - Running setup.py install for mozversion 09:08:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:08:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:08:14 INFO - Cleaning up... 09:08:14 INFO - Return code: 0 09:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:14 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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:08:14 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 09:08:14 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 09:08:14 INFO - Using env: {'DISPLAY': ':0', 09:08:14 INFO - 'HOME': '/home/cltbld', 09:08:14 INFO - 'LANG': 'en_US.UTF-8', 09:08:14 INFO - 'LANGUAGE': 'en_US:en', 09:08:14 INFO - 'LOGNAME': 'cltbld', 09:08:14 INFO - 'MAIL': '/var/mail/cltbld', 09:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:14 INFO - 'MOZ_NO_REMOTE': '1', 09:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:14 INFO - 'NO_EM_RESTART': '1', 09:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:14 INFO - 'PWD': '/builds/slave/test', 09:08:14 INFO - 'SHELL': '/bin/bash', 09:08:14 INFO - 'SHLVL': '1', 09:08:14 INFO - 'TERM': 'linux', 09:08:14 INFO - 'TMOUT': '86400', 09:08:14 INFO - 'USER': 'cltbld', 09:08:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:14 INFO - '_': '/tools/buildbot/bin/python'} 09:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:14 INFO - Running setup.py (path:/tmp/pip-xCo5S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:14 INFO - Running setup.py (path:/tmp/pip-oOLlEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:14 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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:14 INFO - Running setup.py (path:/tmp/pip-2WBDv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08: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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:14 INFO - Running setup.py (path:/tmp/pip-36cBdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08: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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:14 INFO - Running setup.py (path:/tmp/pip-qqaThn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08: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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:14 INFO - Running setup.py (path:/tmp/pip-9u6oRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08: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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:14 INFO - Running setup.py (path:/tmp/pip-J0Dyft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08: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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:14 INFO - Running setup.py (path:/tmp/pip-uinjcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08: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)) 09:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:14 INFO - Running setup.py (path:/tmp/pip-XMEWyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:15 INFO - Running setup.py (path:/tmp/pip-nIq6D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:15 INFO - Running setup.py (path:/tmp/pip-ugoRvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:15 INFO - Running setup.py (path:/tmp/pip-vZIls3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:15 INFO - Running setup.py (path:/tmp/pip-39oT6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:15 INFO - Running setup.py (path:/tmp/pip-Gfoy6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:15 INFO - Running setup.py (path:/tmp/pip-64Utwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:15 INFO - Running setup.py (path:/tmp/pip-UgQ2TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:15 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)) 09:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:15 INFO - Running setup.py (path:/tmp/pip-7G0H6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08: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)) 09:08: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)) 09:08: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)) 09:08: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)) 09:08: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)) 09:08: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)) 09:08:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:17 INFO - Downloading blessings-1.6.tar.gz 09:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:08:17 INFO - Installing collected packages: blessings 09:08:17 INFO - Running setup.py install for blessings 09:08:17 INFO - Successfully installed blessings 09:08:17 INFO - Cleaning up... 09:08:17 INFO - Return code: 0 09:08:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:18 INFO - Reading from file tmpfile_stdout 09:08:18 INFO - Current package versions: 09:08:18 INFO - argparse == 1.2.1 09:08:18 INFO - blessings == 1.6 09:08:18 INFO - blobuploader == 1.2.4 09:08:18 INFO - docopt == 0.6.1 09:08:18 INFO - functools32 == 3.2.3-2 09:08:18 INFO - jsonschema == 2.5.1 09:08:18 INFO - manifestparser == 1.1 09:08:18 INFO - mozInstall == 1.12 09:08:18 INFO - mozcrash == 1.0 09:08:18 INFO - mozdebug == 0.1 09:08:18 INFO - mozdevice == 0.49 09:08:18 INFO - mozfile == 1.2 09:08:18 INFO - mozhttpd == 0.7 09:08:18 INFO - mozinfo == 0.9 09:08:18 INFO - mozleak == 0.1 09:08:18 INFO - mozlog == 3.4 09:08:18 INFO - moznetwork == 0.27 09:08:18 INFO - mozprocess == 0.24 09:08:18 INFO - mozprofile == 0.28 09:08:18 INFO - mozrunner == 6.13 09:08:18 INFO - mozscreenshot == 0.1 09:08:18 INFO - mozsystemmonitor == 0.3 09:08:18 INFO - moztest == 0.8 09:08:18 INFO - mozversion == 1.4 09:08:18 INFO - psutil == 3.1.1 09:08:18 INFO - requests == 1.2.3 09:08:18 INFO - wsgiref == 0.1.2 09:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:18 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')]} 09:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:18 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')]} 09:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:18 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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:08:18 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 09:08:18 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 09:08:18 INFO - Using env: {'DISPLAY': ':0', 09:08:18 INFO - 'HOME': '/home/cltbld', 09:08:18 INFO - 'LANG': 'en_US.UTF-8', 09:08:18 INFO - 'LANGUAGE': 'en_US:en', 09:08:18 INFO - 'LOGNAME': 'cltbld', 09:08:18 INFO - 'MAIL': '/var/mail/cltbld', 09:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:18 INFO - 'MOZ_NO_REMOTE': '1', 09:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:18 INFO - 'NO_EM_RESTART': '1', 09:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:18 INFO - 'PWD': '/builds/slave/test', 09:08:18 INFO - 'SHELL': '/bin/bash', 09:08:18 INFO - 'SHLVL': '1', 09:08:18 INFO - 'TERM': 'linux', 09:08:18 INFO - 'TMOUT': '86400', 09:08:18 INFO - 'USER': 'cltbld', 09:08:18 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:18 INFO - '_': '/tools/buildbot/bin/python'} 09:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 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)) 09:08:18 INFO - Cleaning up... 09:08:18 INFO - Return code: 0 09:08:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:08:18 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')]} 09:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:18 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')]} 09:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:18 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 0x27801f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2890a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, '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': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', '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 09:08:18 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 09:08:18 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 09:08:18 INFO - Using env: {'DISPLAY': ':0', 09:08:18 INFO - 'HOME': '/home/cltbld', 09:08:18 INFO - 'LANG': 'en_US.UTF-8', 09:08:18 INFO - 'LANGUAGE': 'en_US:en', 09:08:18 INFO - 'LOGNAME': 'cltbld', 09:08:18 INFO - 'MAIL': '/var/mail/cltbld', 09:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:18 INFO - 'MOZ_NO_REMOTE': '1', 09:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:18 INFO - 'NO_EM_RESTART': '1', 09:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:18 INFO - 'PWD': '/builds/slave/test', 09:08:18 INFO - 'SHELL': '/bin/bash', 09:08:18 INFO - 'SHLVL': '1', 09:08:18 INFO - 'TERM': 'linux', 09:08:18 INFO - 'TMOUT': '86400', 09:08:18 INFO - 'USER': 'cltbld', 09:08:18 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:18 INFO - '_': '/tools/buildbot/bin/python'} 09:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:08:18 INFO - Cleaning up... 09:08:18 INFO - Return code: 0 09:08:18 INFO - Running post-action listener: _resource_record_post_action 09:08:18 INFO - Running post-action listener: _start_resource_monitoring 09:08:18 INFO - Starting resource monitoring. 09:08:18 INFO - [mozharness: 2017-02-24 17:08:18.598469Z] Finished create-virtualenv step (success) 09:08:18 INFO - [mozharness: 2017-02-24 17:08:18.598925Z] Running install step. 09:08:18 INFO - Running pre-action listener: _resource_record_pre_action 09:08:18 INFO - Running main action method: install 09:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:18 INFO - Reading from file tmpfile_stdout 09:08:18 INFO - Detecting whether we're running mozinstall >=1.0... 09:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:08:18 INFO - Reading from file tmpfile_stdout 09:08:18 INFO - Output received: 09:08:18 INFO - Usage: mozinstall [options] installer 09:08:18 INFO - Options: 09:08:18 INFO - -h, --help show this help message and exit 09:08:18 INFO - -d DEST, --destination=DEST 09:08:18 INFO - Directory to install application into. [default: 09:08:18 INFO - "/builds/slave/test"] 09:08:18 INFO - --app=APP Application being installed. [default: firefox] 09:08:18 INFO - mkdir: /builds/slave/test/build/application 09:08: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'] 09:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:08:35 INFO - Reading from file tmpfile_stdout 09:08:35 INFO - Output received: 09:08:35 INFO - /builds/slave/test/build/application/firefox/firefox 09:08:35 INFO - Running post-action listener: _resource_record_post_action 09:08:35 INFO - [mozharness: 2017-02-24 17:08:35.382511Z] Finished install step (success) 09:08:35 INFO - [mozharness: 2017-02-24 17:08:35.382783Z] Running run-tests step. 09:08:35 INFO - Running pre-action listener: _resource_record_pre_action 09:08:35 INFO - Running main action method: run_tests 09:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:35 INFO - Python 2.7.3 09:08:35 INFO - Return code: 0 09:08:35 INFO - grabbing minidump binary from tooltool 09:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:35 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 0x2b7b850>, '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 0x2af06d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:35 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 09:08:35 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 09:08:35 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 09:08:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:35 INFO - Return code: 0 09:08:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:08:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:08:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:08:35 INFO - Using env: {'DISPLAY': ':0', 09:08:35 INFO - 'HOME': '/home/cltbld', 09:08:35 INFO - 'LANG': 'en_US.UTF-8', 09:08:35 INFO - 'LANGUAGE': 'en_US:en', 09:08:35 INFO - 'LOGNAME': 'cltbld', 09:08:35 INFO - 'MAIL': '/var/mail/cltbld', 09:08:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:35 INFO - 'MOZ_NO_REMOTE': '1', 09:08:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:35 INFO - 'NO_EM_RESTART': '1', 09:08:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:35 INFO - 'PWD': '/builds/slave/test', 09:08:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:35 INFO - 'SHELL': '/bin/bash', 09:08:35 INFO - 'SHLVL': '1', 09:08:35 INFO - 'TERM': 'linux', 09:08:35 INFO - 'TMOUT': '86400', 09:08:35 INFO - 'USER': 'cltbld', 09:08:35 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699', 09:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:35 INFO - '_': '/tools/buildbot/bin/python'} 09:08:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:08:35 INFO - mozversion application_buildid: 20170224161212 09:08:35 INFO - mozversion application_changeset: 4851173666d03c2be1e2d72705650c69cfc35dfb 09:08:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:08:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:35 INFO - mozversion application_name: Firefox 09:08:35 INFO - mozversion application_remotingname: firefox-dev 09:08:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:08:35 INFO - mozversion application_vendor: Mozilla 09:08:35 INFO - mozversion application_version: 53.0a2 09:08:35 INFO - mozversion platform_buildid: 20170224161212 09:08:35 INFO - mozversion platform_changeset: 4851173666d03c2be1e2d72705650c69cfc35dfb 09:08:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:08:35 INFO - mozversion platform_version: 53.0a2 09:08:35 INFO - using testdate: 1487956115 09:08:35 INFO - actual date: 1487956115 09:08:35 INFO - starting webserver on 'localhost:48976' 09:08:35 INFO - SUITE-START | Running 2 tests 09:08:35 INFO - TEST-START | dromaeo_css 09:08:35 INFO - operating with platform_type : linux_ 09:08:35 INFO - Initialising browser for dromaeo_css test... 09:08:35 INFO - TEST-INFO | started process 2913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwarZIi/profile http://localhost:48976/getInfo.html) 09:08:39 INFO - PROCESS | 2913 | __metrics Screen width/height:1600/1200 09:08:39 INFO - PROCESS | 2913 | colorDepth:24 09:08:39 INFO - PROCESS | 2913 | Browser inner width/height: 1024/697 09:08:39 INFO - PROCESS | 2913 | __metrics 09:08:40 INFO - PROCESS | 2913 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:08:40 INFO - PROCESS | 2913 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:41 INFO - TEST-INFO | 2913: exit 0 09:08:41 INFO - Browser initialized. 09:08:41 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:41 INFO - TEST-INFO | started process 3026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwarZIi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:53 INFO - PROCESS | 3026 | RSS: Main: 137900032 09:08:53 INFO - PROCESS | 3026 | 09:11:54 INFO - PROCESS | 3026 | Cycle 1(1): loaded http://localhost:48976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48976/tests/dromaeo/cssquery-ext.html) 09:11:55 INFO - PROCESS | 3026 | RSS: Main: 242774016 09:11:55 INFO - PROCESS | 3026 | 09:13:43 INFO - PROCESS | 3026 | ************************* 09:13:43 INFO - PROCESS | 3026 | A coding exception was thrown and uncaught in a Task. 09:13:43 INFO - PROCESS | 3026 | 09:13:43 ERROR - PROCESS | 3026 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:43 INFO - PROCESS | 3026 | Full stack: 09:13:43 INFO - PROCESS | 3026 | ************************* 09:14:57 INFO - PROCESS | 3026 | Cycle 1(1): loaded http://localhost:48976/tests/dromaeo/cssquery-ext.html (next: http://localhost:48976/tests/dromaeo/cssquery-jquery.html) 09:14:57 INFO - PROCESS | 3026 | RSS: Main: 224301056 09:14:57 INFO - PROCESS | 3026 | 09:17:59 INFO - PROCESS | 3026 | Cycle 1(1): loaded http://localhost:48976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48976/tests/dromaeo/cssquery-mootools.html) 09:18:00 INFO - PROCESS | 3026 | RSS: Main: 229306368 09:18:00 INFO - PROCESS | 3026 | 09:21:02 INFO - PROCESS | 3026 | Cycle 1(1): loaded http://localhost:48976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48976/tests/dromaeo/cssquery-prototype.html) 09:21:02 INFO - PROCESS | 3026 | RSS: Main: 213114880 09:21:02 INFO - PROCESS | 3026 | 09:24:05 INFO - PROCESS | 3026 | Cycle 1(1): loaded http://localhost:48976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48976/tests/dromaeo/cssquery-yui.html) 09:24:06 INFO - PROCESS | 3026 | RSS: Main: 174743552 09:24:06 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | Cycle 1(1): loaded http://localhost:48976/tests/dromaeo/cssquery-yui.html (next: http://localhost:48976/tests/dromaeo/cssquery-dojo.html) 09:27:08 INFO - PROCESS | 3026 | RSS: Main: 259682304 09:27:08 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | __start_tp_report 09:27:08 INFO - PROCESS | 3026 | _x_x_mozilla_page_load 09:27:08 INFO - PROCESS | 3026 | _x_x_mozilla_page_load_details 09:27:08 INFO - PROCESS | 3026 | |i|pagename|runs| 09:27:08 INFO - PROCESS | 3026 | |0;dojo.html;3301.3727391795555;3323.800571965684;3334.9166270843234;3362.058623585394;3375;5421.9457805421935;5470.91793623096;5484.972575137123;5492.560595152383;5513.696746678931;5515.817196899404;5563.610547261694;5571.470710282517;5579.38626751057;5599.804006859761;5055.039542486925;5072.3405957225505;5103.311053007852;5105.336306280197;5187.8443646690475;4932.827351042714;5109.69341839489;5162.870928226786;5166.535011848933;5170.560502357304;4935.605151587883;5052.989402119572;5084.567811736007;5113.386393632751;5188.896222075557;5126.179811230204;5159.303494028296;5161.406438259611;5165.586753059746;5166.121759300928;5001.824936127255;5064.9746751266375;5112.514311140436;5117.8464646060675;5151.5621172200035;5340.25236466895;5367.758450869681;5407.972960135174;5408.45915408456;5483.122700367922;5938.584299099065;5972.432618901241;5978.342382337939;5978.581499295051;6000.729967151488;5957.791477298274;5991.730372133221;5999.790007349722;6015.398460153993;6021.5182785377065;5475.479829416199;5477.67133971963;5482.835514934558;5505.559555235572;5640.520555752766;6062.393760623902;6064.36324185963;6091.08633704939;6094.268687757498;6095.177151084636;5787.1319302104175;5840.415958404211;5848.619839710405;5850.882982340329;5854.941450585439;5755.251817263729;5794.768209271666;5928.0515117581845;5928.288605367297;5932.466078052996;5759;5862;5887.175795388649;5945.346011938684;5966.134910437962;5957.2255606771705;5960.433758792908;5965.910511342333;5967.16459695643;5970.9701451492465;4483.3723278741;4617.561331673485;4623.352730617717;4629.837955671535;4653.674242802971;4035.6771458283265;4050.1697152083752;4071.42999980003;4096.856610018635;4154.169166166718;5802.448767367094;5803.564732645069;5804.506616937523;5805.535557155417;5806.941930580725;5748.338941021836;5803.622764520293;5861.296644402613;5990.760369585168;5992.221011268594;5674.432556744293;5766.077427611646;5769.07694768835;5782.10377391505;5804.564657650693;5057.69653820772;5062.924056139161;5067.037262920034;5076.7207803571155;5079.6698214615935;6034.48706859913;6070.3019152798;6125.418085281891;6170.660613666291;6233.594816337014;5779.566532510163;5811.79658711943;5846.766129354778;5913.822585322448;5955.344912059583;6109.908351374822;6161.075838624242;6167.044108163242;6169.352218017223;6170.845728856814;5680.971595141998;5833.095870140135;5833.883322333445;5837.445442682938;5838.2702162229725;5776.537876969748;5838.241028666416;5841.678707671119;5886.264216972879;5991;5763.308402991668;5815.534757219497;5822.854428639149;5823.039198532364;5827.388124246893;5804.912926306193;5817.621854579439;5825.213596164633;5830.038043722739;5830.18377427169;5582.553395728413;5588.189712491747;5591.748371323219;5639.041362968387;5639.492445679908;5723;5753.482186603226;5761.942380576308;5772.942270577409;5776.451237132465;5628.85927851807;5637.182608521824;5646.322441307069;5651.8304450866535;5665.065264231355 09:27:08 INFO - PROCESS | 3026 | |1;ext.html;544.5072209650266;614.3672017821644;616.198941376211;648.354886887547;656.6880731652466;39005.80497097514;47749;48261.75869120658;48326.033479330436;51882.48117518824;50181.24728129072;50503.24245136326;50540.494595054035;50571.49428505723;50694;8764.56177191141;8951.104889511062;9378.718638440841;9564.80870382592;9569.904300957005;10994.34033957961;11297.548098076068;11304.321740695543;11679.182457227955;11694.532218711242;11325.830112548318;11399.316041037522;11407.25852819564;11408.71478213043;11415.714607134805;11164.162687798407;11191.552337906474;11200.607978720787;11208.887911120866;11269.887301127048;11080.113590912708;11177.66467005991;11179.441027948651;11189.160812939062;11190.496427660775;47121.528784712056;47137;47435.52564474346;47542;47587.286190707164;4294.26997410441;4381.956180438218;4460.643148548108;4537.478190008125;4548.795304211319;33642.49536256958;33750.83124584386;33817.154571135674;34165.65834341649;35711.4643280351;4514.6614003949835;4562.087582483517;4598.333241679971;4602.424696912886;4628.907421851578;351057;351856;352935;353232;353317.23341383383;65915.34084659188;66009;66128.33871661319;66830;66873.33126668769;71652;71657;71781.2821871785;71845.64077179685;71919.64040179871;19518.902405488167;20055.59888802216;20067.698984515246;20077;20089.497762556053;13694.246816424993;13889.583312500641;15181.392744290326;15561.221938903009;15656.765148522782;18919;19303.710444343345;19335.8066419334;19348.32280870163;19374;7004.544704594185;7130.25132361105;7130.358267755927;7294.562326260335;7295.161056478573;974.3228456222857;975.1272611013104;981.9656312029188;994.9900500995042;1001.7245257554231;32765.836170818995;33365.499517507254;33649.83175084109;33825.661743382254;33899.491507627405;1100.1528822806395;1161.976760464786;1171.3499008050615;1192.9463174157183;1195.6831439668495;17696.734548981774;17841.197146128456;17969.910150449163;17980.190891409657;18011.819881801275;495983;498459;498661;500871;505228;65913;66265.33734662688;66656.33343666501;66668.33331666718;66690.33309666938;1534.8465153484563;1543.7221300165854;1569.4977607165597;1582.2247098921675;1600.9359625614845;31176.844115780183;32696.836515817267;32844.50733239051;32959.67040329566;33581;56618;57246;57246.42753572411;57246.713766430905;57293.999999998334;394221;394850;395034;396072;396099;38073.619263807006;43402;44039.77980110079;44318.556814431446;47519.524804752895;50666.493335066174;51256.74371628267;51325;51502;51570;42091;43902;44045.79771011501;44674.10651787011;45644.315335270665;42211.577884220766;42548.149037019706;42923.35614965841;44442.77778611216;44575.33137003012;42138;42492;43065.569344306154;43696.34455483107;43794;36273.63726362808;37811.243775123796;38235;38768.22463550769;38920.80539597284;27979.160625181277;28160.85919570389;28241.71758282473;28244.293892652848;28472 09:27:08 INFO - PROCESS | 3026 | |2;jquery.html;403.12320702472135;409.3532219093832;416.93120635095204;418.6002367738811;432.63442391179444;20083.899580502097;20322.381151874222;21380.037898294577;21752.782472175273;21811.67282490762;21520.246791362304;21894.89052554739;22450.55098898021;22571;22743.31770046897;5974.910376344358;6167.321594624587;6201.472874805624;6208.161898143738;6209.596376235553;5906.084556893667;6015.3383127855905;6027.608205466652;6102.298235702907;6105.389461053904;6065.545084118687;6076.787312444066;6081.54388420868;6082.787102451415;6084.056971169476;5874.089516124986;5984.5212383009475;6018.127371531147;6028.1861948636815;6028.4272994065495;5286.392064912546;5330.067238233293;5411.729413529308;5416.187571864252;5424.294841670558;25403.745962540506;25611;25647.974081036737;25724.87137564319;25863;2793.1620513845764;3018.622672165979;3023.425549145655;3048.481758101128;3051.343961048363;15013.849861501354;15689.607759805982;15734.842651573452;15737.213139342986;15778.76331855023;1954.1304119666754;1983.3256692724399;2002.8497862660358;2006.17746723844;2008.9497762556052;96681;98993.50503247509;100019;100700.49649751777;102396;12038.277703337828;12163;12172.391380430943;12181.269123852597;12239.632811015685;17400.303987840343;17431.12844357777;17433.21550530229;17450;17475.650486990442;9019.909800901907;9132.452052876848;9173.633054677872;9231.353805233703;9372;8796.516191609522;8854.734357969272;8894.332925030649;9062.954685226532;9131.589078491485;5143.7685304161405;5186.688798672017;5200.531952124327;5252.5535329497425;5340.465953404629;2033.3188381891937;2093.204582258732;2128.6274901892416;2131.296672098204;2135.8214621086404;941.8445956417114;947.5830634520789;966.8984756600596;967.67099186277;968.1141755293968;19009.714854277197;20769.48825683585;20881.37355879326;20992.685109723367;21045.579088418144;956.220680145693;966.1256562810668;968.3173362779364;976.1019861727086;977.1010670183448;10820.78358432827;11595.246308989888;11624.593139240085;11631.53473861053;11710.94144529272;676639;693071;705061;717108;721434;66388;86030.56984715162;102482;108946.45526772315;112680;1066.36018388966;1070.71626019105;1107.5293000474767;1112.67732357617;1114.4817659788237;18333.3583324583;18873.339433119774;18894.433167005012;19086.809131908503;19335.903320483307;42446;42866.78566607147;45931.77034114808;46181.76909115567;46298.768506157256;62503.6874815623;62949.37050629435;63051.684741576;63311.36688633055;63578.68210658917;9264.861027084735;9374.812503750023;9439.150476456876;9526.142647161789;9713.9028609713;8626.870596941177;9811.474554283732;12614.36928153607;13131.474741010252;14075.366608502847;7461;11196.66410007701;12170.330631815335;12269.69325766863;12574;5894.911576326444;10184;11971.683114857533;11991.280523168638;12524.373781310716;12270.81593776112;12674.683132921382;12810.871891280967;12994.220346779224;13043.152195107288;9407.85888211691;9454.905450945402;9571.904280957102;9587.137157655845;9628.422294662343;9525.476098814632;12374.505019799108;12502;12508.749825003268;12539 09:27:08 INFO - PROCESS | 3026 | |3;mootools.html;1485.777133429986;1508.969820603588;1520.3234560620524;1529.5411376587024;1547.8452154784516;8208.876866847002;8734.606942687578;8745.562721863913;8755.036945935943;8828.337874659393;7761.146273909865;7966.004249468817;8452.323814094872;8662.047174810767;8708.651653933835;2336.7079115110655;2374.00291877411;2374.1097088591778;2378.8096952243777;2381.8094552435764;2421.3462365161395;2443.755624437551;2451.3258853815164;2453.3989172652723;2455.58255096634;2335.427820184049;2362.70466191726;2368.7039120109985;2377.785999260066;2396.317049640853;2309.549637820626;2317.826163037762;2330.4406942333885;2344.1678204237505;2379.298107058422;2316.6872472216373;2319.605667036591;2336.7780060894356;2345.4370950971816;2345.5308938212424;8557.400981931267;8685.392022558424;8698.260647844942;8705.434146780439;8724.34567407447;5297.258383826267;5440.483154100354;5446.645968012106;5452.536534394581;5454.61817672763;3391.2030672791875;3392.1858753899132;3446.6208717041104;3465.5668041494814;3488.3197776433353;1312.3110367057275;1349.5074297881301;1392.220356600307;1398.7971744097151;1462.6489642485833;11810.822837657443;11933.34366609836;11945.940270298679;11959.940200298943;11967.880321196852;4588.678792484561;4791.712497250176;4821.927671084936;4831.106245344622;4831.51684831514;10419.687409377731;10436.947815261026;10442.112420444195;10443.738906527398;10449.111825494767;5472.91790623141;5491.258680078218;5506.504414602705;5511.807086751945;5515.751791169407;4228.70399072062;4806.591439727662;4854.781534830941;4872.342233798392;4931.5315045070665;4096.603486960162;4144.958550414518;4183.372494125905;4219.662427005894;4224.134052519226;1285.6693322411447;1292.8707129286995;1304.0284987684236;1304.4847285322244;1306.046585992231;852.6589364254348;897.4166791585391;921.7787730944525;939.6335429182624;969.2052516936045;5908.438698323653;5922.911156332659;5931.73307201177;5950.464458198696;6308.558400911892;1032.9773524211128;1050.238577031646;1069.6256310291335;1087.9020888119949;1117.3910218930703;3943.881683549441;3946.5264168299414;4079.265732168179;4150.584941505886;4170.52039015511;10406.947965260277;10767.246292759588;10768.3538987661;10771.676849694522;10774.892251077388;10685.679429617125;10707.946460267805;10719.78560428787;10730.73173170677;10734.73163170927;7872.763817085496;8245.628946697292;8249.670013199524;8368.37237207212;8582.485050896841;5818.214541037075;5851.151583020353;5977.535503801597;5993.280806303272;6074.848128796639;9675.22598192157;9747.415155090717;9751.268654850772;9774.169195618451;9888.802223955625;9758.756031098996;9932.602695892372;9941.950290248502;10104.343217691121;10107.848382274125;6952.7137479566445;7141.64291785419;7147.106611673541;7503.474756766974;7722.073351197892;7985.480943738638;8057.879131813144;8207.917920820953;8306.626201821053;8322.54226017575;7507.249275072449;7594.5063570869925;7668.846623067396;7673.309402153833;7677.193894640982;7490.662920168496;7523.059617547807;7660.119086304923;7666.693332266647;7696.114946781192;6556.246031706415;6576.2766095730385;6652.234992975869;6661.533692641468;6670.066190733204;5108.56577190943;5109.514596113363;5167.379914410295;5176.637635365639;5253.212018197301;5074.619403544675;5098.515641014098;5099.872503187302;5117.257997590403;5261.342332208474 09:27:08 INFO - PROCESS | 3026 | |4;prototype.html;363.93994990826513;374.4701247734456;374.6384738727128;378.54763557548733;381.3973921204497;5213.270142180088;5327.893442131165;5420.295361602991;5461.9453805461935;5481.040817856879;5292.311999440068;5347.609621498409;5379.408265090837;5409.702466364358;5411.998780225661;4321.351797230409;4329;4332.3284890841815;4370.628496577795;4387.429634147572;4242.448481697375;4302.354646802989;4314.417553630266;4316.460442444694;4348.630366418858;4287.5498072702385;4297.892552686192;4306.224879521685;4310.310350343945;4323.437953066113;4282.657387409015;4291.291936830419;4297.484301883794;4304.806283717225;4340.782960851945;3733.45864849598;3903.1217975955183;3918.1771827916173;3922.7057970652313;3929.4302326162833;5264.578833693296;5271.209318602202;5303.257543943851;5311.867203319909;5313.867153321198;4965.889496963776;4977.626677999165;4980.452150263468;4981.352424184869;4986.177280748672;5444.5916556258435;5601.467860553241;5664.830055098354;5736.565858535366;5746.569007324468;4178.979105104455;4184.14225083857;4205.285101532747;4217.177650358181;4227.471566054243;5844.240248767675;5883.676397798119;5887.087501437284;5910.438508341744;5941.55438342126;4200.4053635792125;4235.385869048971;4343.218220720238;4351.43431353922;4352.69531132824;4326.567343265649;4414.646828253732;4419.160359531678;4419.40338054365;4420.8673739787855;4901.681390709592;4923.630727695438;4932.988737308843;4984.925226121611;4999.950000500021;5579.860503487364;5721.141828725725;5723.370429252779;5730.856728581819;5766.185235328548;1489.7318482673006;1493.3429291111877;1494;1495.3719437836135;1500.4545318322146;1015.962994196631;1027.6403258859489;1035.5443604813859;1038.4081073787868;1046.1630695443614;5337.653052551572;5406.8918621627345;5414.752877555849;5434.402215756264;5453.618246722692;5643.887122257532;5659.971700141473;5665.773369065191;5673.461021202979;5690.374058853523;5337.238711225286;5344.35867695879;5344.679319240858;5417.729113544386;5518.089515229942;2995.1912983494335;2998.7001299870276;3000.4599172149224;3002.3995200959457;3007.0978706387996;5632.690202038845;5867.442592953748;5876.7355469004;5890.293164820249;5965.403459654;5770.672745268528;5800.883982320414;5800.941990580124;5813.331466881278;5815.022892216667;5863.2670916135485;5877.853053673607;5882.411758824083;5886.911696324559;5887.676177810176;5430.755615997368;5533.320341972543;5692.658440493584;5731.111677689964;5820.489120931312;5747.4252574742195;5757.971210143923;5761.683107429131;5762.366139724711;5771;5879.7060146993335;5984;6054.576179667381;6113.633182009094;6118.388161184024;3950.9209815804097;4055.574164712663;4058.918821623492;4165.812538435717;4186.706930514834;5794.275715535558;5819.476247137778;5819.854503637443;5835.183074369506;5867.885101830639;5568.605499635196;5707.828765137053;5718.456746609066;5720.656760594377;5726.656400615976;5646.943530564642;5682.6306290091015;5686.947914635805;5701.686407247641;5704.201411802268;5626.606137570331;5633.633813802254;5643.181738647955;5686.34607020198;5708.942910570841;5517.917231241454;5688.687122208153;5727.942720572741;5731.484166425042;5753.367129615655;5565.886822635408;5594.3286805581965;5605.831825045255;5611.607187496999;5617.764091899776 09:27:08 INFO - PROCESS | 3026 | |5;yui.html;716.5449939288553;743.1602289412963;771.3019717155972;852.1946760311504;855.2345650642677;14798.260086995648;15274.465393711236;15705.136217508047;17221.82778172218;17566;15274.541763747106;15411.768823467657;16083.437079702213;16144.273507692153;16189.433369832059;712.2343480758179;827.6523859978823;835.3859912963967;835.7743409279491;837.844998675244;726.2519604807057;735.9926400736005;737.074970911508;803.895493585836;826.0335407573124;872.7294538693026;876.9693060742875;877.6401675313123;877.7279043496504;877.9253763430116;861.3884142258972;863.7322430046643;863.7754183912197;863.9481631102091;865.0398058155442;545.6262460214726;558.8882223555305;619.0373968479013;637.6078711592384;638.5753473939825;15826.683466330724;16525.504234872973;16544.42094526686;16550.42073527433;16573.337066517324;14327;14432.783508247385;14511.927440362837;14629.122252664767;15442.227888605637;12717.809232861515;12930.547430839875;12936.417861196269;12963.805542916863;13202.009849261343;4024.2957482440456;4034.536028356747;4039.8788036358956;4078.449409329732;4112.753234805921;84512;85357;85728.14271857326;86486;87587.56206218927;11864.406779660982;11868.762624747456;11882.821757673642;11957.880421195676;12080.879191207976;21759.45601359947;21785.23751668684;22382.776172238067;22686.886565567067;24393.14623988152;9154.176124148858;9176.44941303524;9186.908130918739;9193.448393096436;9257.444553326823;4910.8281210157475;4966.553010229097;5031.018951304533;5150.742462876841;5170.250313704491;3707.0917625182;3807.5811660717854;3816.3321418751607;3816.3893776995546;3816.637419445148;634.0995785983914;639.9200099987502;650.905618685288;651.7751375775445;655.2791928878196;807.6325272001226;811.7443005453264;818.5048045932244;829.4401279136558;839.9328053755685;10636.255462117731;10725.410102444284;10762.677119686421;11968.10239232061;11996.880031199751;650.8568115014689;683.8392977650249;699.9860002800017;715.3025799845109;716.9820754481179;4878.658493905464;5321.86695332612;5359.490848369399;5408.810691625774;5436;72827.2717272831;73804.63097684477;75578;77102;78602.60698696584;55484.44515554873;63516.36483635197;66634;67181;70796.29203708;59173.40826591765;62094;62665.68667156635;62786;63004;11063;11169;11252.468194656465;11297.774044519228;11458.713532161762;42031.15937681168;43084.13831723285;43262.56737432711;43885.34171987359;43919;51640;52149;52312.738436307576;52428.21357679561;52540.211896822344;13665.658358541115;13922.09506382082;13948.232847193502;14008.229547374993;14037.859621403655;14403.855961440251;14458.566243012727;14466.27668616544;14511;14558.927205363905;13698.657533561342;13924.443022278996;14200.502982395567;14527.128372297273;14665.413383464542;13039.087263891815;13093.279869607262;13129.146605470614;13167.53913613019;13295.66760830987;13085.08404411682;13202.207867527979;13273.402696878471;13389.263590502616;13546.390412431661;11847.526098955945;11854.881451185378;12067.396630168281;12180.33008184523;12287.1399002069;11248.100151987657;11532.135089868125;11539.596114135966;11617.477213525242;11626.069914406997 09:27:08 INFO - PROCESS | 3026 | __end_tp_report 09:27:08 INFO - PROCESS | 3026 | __start_cc_report 09:27:08 INFO - PROCESS | 3026 | _x_x_mozilla_cycle_collect,926 09:27:08 INFO - PROCESS | 3026 | __end_cc_report 09:27:08 INFO - PROCESS | 3026 | __startTimestamp1487957228699__endTimestamp 09:27:08 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | ------- Summary: start ------- 09:27:08 INFO - PROCESS | 3026 | Number of tests: 6 09:27:08 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | [#0] dojo.html Cycles:165 Average:5517.97 Median:5761.94 stddev:598.23 (10.4%) stddev-sans-first:574.23 09:27:08 INFO - PROCESS | 3026 | Values: 3301.4 3323.8 3334.9 3362.1 3375.0 5421.9 5470.9 5485.0 5492.6 5513.7 5515.8 5563.6 5571.5 5579.4 5599.8 5055.0 5072.3 5103.3 5105.3 5187.8 4932.8 5109.7 5162.9 5166.5 5170.6 4935.6 5053.0 5084.6 5113.4 5188.9 5126.2 5159.3 5161.4 5165.6 5166.1 5001.8 5065.0 5112.5 5117.8 5151.6 5340.3 5367.8 5408.0 5408.5 5483.1 5938.6 5972.4 5978.3 5978.6 6000.7 5957.8 5991.7 5999.8 6015.4 6021.5 5475.5 5477.7 5482.8 5505.6 5640.5 6062.4 6064.4 6091.1 6094.3 6095.2 5787.1 5840.4 5848.6 5850.9 5854.9 5755.3 5794.8 5928.1 5928.3 5932.5 5759.0 5862.0 5887.2 5945.3 5966.1 5957.2 5960.4 5965.9 5967.2 5971.0 4483.4 4617.6 4623.4 4629.8 4653.7 4035.7 4050.2 4071.4 4096.9 4154.2 5802.4 5803.6 5804.5 5805.5 5806.9 5748.3 5803.6 5861.3 5990.8 5992.2 5674.4 5766.1 5769.1 5782.1 5804.6 5057.7 5062.9 5067.0 5076.7 5079.7 6034.5 6070.3 6125.4 6170.7 6233.6 5779.6 5811.8 5846.8 5913.8 5955.3 6109.9 6161.1 6167.0 6169.4 6170.8 5681.0 5833.1 5833.9 5837.4 5838.3 5776.5 5838.2 5841.7 5886.3 5991.0 5763.3 5815.5 5822.9 5823.0 5827.4 5804.9 5817.6 5825.2 5830.0 5830.2 5582.6 5588.2 5591.7 5639.0 5639.5 5723.0 5753.5 5761.9 5772.9 5776.5 5628.9 5637.2 5646.3 5651.8 5665.1 09:27:08 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | [#1] ext.html Cycles:180 Average:60910.97 Median:42351.79 stddev:110713.61 (261.4%) stddev-sans-first:110931.42 09:27:08 INFO - PROCESS | 3026 | Values: 544.5 614.4 616.2 648.4 656.7 39005.8 47749.0 48261.8 48326.0 51882.5 50181.2 50503.2 50540.5 50571.5 50694.0 8764.6 8951.1 9378.7 9564.8 9569.9 10994.3 11297.5 11304.3 11679.2 11694.5 11325.8 11399.3 11407.3 11408.7 11415.7 11164.2 11191.6 11200.6 11208.9 11269.9 11080.1 11177.7 11179.4 11189.2 11190.5 47121.5 47137.0 47435.5 47542.0 47587.3 4294.3 4382.0 4460.6 4537.5 4548.8 33642.5 33750.8 33817.2 34165.7 35711.5 4514.7 4562.1 4598.3 4602.4 4628.9 351057.0 351856.0 352935.0 353232.0 353317.2 65915.3 66009.0 66128.3 66830.0 66873.3 71652.0 71657.0 71781.3 71845.6 71919.6 19518.9 20055.6 20067.7 20077.0 20089.5 13694.2 13889.6 15181.4 15561.2 15656.8 18919.0 19303.7 19335.8 19348.3 19374.0 7004.5 7130.3 7130.4 7294.6 7295.2 974.3 975.1 982.0 995.0 1001.7 32765.8 33365.5 33649.8 33825.7 33899.5 1100.2 1162.0 1171.3 1192.9 1195.7 17696.7 17841.2 17969.9 17980.2 18011.8 495983.0 498459.0 498661.0 500871.0 505228.0 65913.0 66265.3 66656.3 66668.3 66690.3 1534.8 1543.7 1569.5 1582.2 1600.9 31176.8 32696.8 32844.5 32959.7 33581.0 56618.0 57246.0 57246.4 57246.7 57294.0 394221.0 394850.0 395034.0 396072.0 396099.0 38073.6 43402.0 44039.8 44318.6 47519.5 50666.5 51256.7 51325.0 51502.0 51570.0 42091.0 43902.0 44045.8 44674.1 45644.3 42211.6 42548.1 42923.4 44442.8 44575.3 42138.0 42492.0 43065.6 43696.3 43794.0 36273.6 37811.2 38235.0 38768.2 38920.8 27979.2 28160.9 28241.7 28244.3 28472.0 09:27:08 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | [#2] jquery.html Cycles:180 Average:36418.29 Median:1727.23 stddev:115312.63 (6676.1%) stddev-sans-first:115604.40 09:27:08 INFO - PROCESS | 3026 | Values: 403.1 409.4 416.9 418.6 432.6 20083.9 20322.4 21380.0 21752.8 21811.7 21520.2 21894.9 22450.6 22571.0 22743.3 5974.9 6167.3 6201.5 6208.2 6209.6 5906.1 6015.3 6027.6 6102.3 6105.4 6065.5 6076.8 6081.5 6082.8 6084.1 5874.1 5984.5 6018.1 6028.2 6028.4 5286.4 5330.1 5411.7 5416.2 5424.3 25403.7 25611.0 25648.0 25724.9 25863.0 2793.2 3018.6 3023.4 3048.5 3051.3 15013.8 15689.6 15734.8 15737.2 15778.8 1954.1 1983.3 2002.8 2006.2 2008.9 96681.0 98993.5 100019.0 100700.5 102396.0 12038.3 12163.0 12172.4 12181.3 12239.6 17400.3 17431.1 17433.2 17450.0 17475.7 9019.9 9132.5 9173.6 9231.4 9372.0 8796.5 8854.7 8894.3 9063.0 9131.6 5143.8 5186.7 5200.5 5252.6 5340.5 2033.3 2093.2 2128.6 2131.3 2135.8 941.8 947.6 966.9 967.7 968.1 19009.7 20769.5 20881.4 20992.7 21045.6 956.2 966.1 968.3 976.1 977.1 10820.8 11595.2 11624.6 11631.5 11710.9 676639.0 693071.0 705061.0 717108.0 721434.0 66388.0 86030.6 102482.0 108946.5 112680.0 1066.4 1070.7 1107.5 1112.7 1114.5 18333.4 18873.3 18894.4 19086.8 19335.9 42446.0 42866.8 45931.8 46181.8 46298.8 62503.7 62949.4 63051.7 63311.4 63578.7 9264.9 9374.8 9439.2 9526.1 9713.9 8626.9 9811.5 12614.4 13131.5 14075.4 7461.0 11196.7 12170.3 12269.7 12574.0 5894.9 10184.0 11971.7 11991.3 12524.4 12270.8 12674.7 12810.9 12994.2 13043.2 9407.9 9454.9 9571.9 9587.1 9628.4 9525.5 12374.5 12502.0 12508.7 12539.0 09:27:08 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | [#3] mootools.html Cycles:180 Average:5753.26 Median:4901.94 stddev:3181.72 (64.9%) stddev-sans-first:3174.48 09:27:08 INFO - PROCESS | 3026 | Values: 1485.8 1509.0 1520.3 1529.5 1547.8 8208.9 8734.6 8745.6 8755.0 8828.3 7761.1 7966.0 8452.3 8662.0 8708.7 2336.7 2374.0 2374.1 2378.8 2381.8 2421.3 2443.8 2451.3 2453.4 2455.6 2335.4 2362.7 2368.7 2377.8 2396.3 2309.5 2317.8 2330.4 2344.2 2379.3 2316.7 2319.6 2336.8 2345.4 2345.5 8557.4 8685.4 8698.3 8705.4 8724.3 5297.3 5440.5 5446.6 5452.5 5454.6 3391.2 3392.2 3446.6 3465.6 3488.3 1312.3 1349.5 1392.2 1398.8 1462.6 11810.8 11933.3 11945.9 11959.9 11967.9 4588.7 4791.7 4821.9 4831.1 4831.5 10419.7 10436.9 10442.1 10443.7 10449.1 5472.9 5491.3 5506.5 5511.8 5515.8 4228.7 4806.6 4854.8 4872.3 4931.5 4096.6 4145.0 4183.4 4219.7 4224.1 1285.7 1292.9 1304.0 1304.5 1306.0 852.7 897.4 921.8 939.6 969.2 5908.4 5922.9 5931.7 5950.5 6308.6 1033.0 1050.2 1069.6 1087.9 1117.4 3943.9 3946.5 4079.3 4150.6 4170.5 10406.9 10767.2 10768.4 10771.7 10774.9 10685.7 10707.9 10719.8 10730.7 10734.7 7872.8 8245.6 8249.7 8368.4 8582.5 5818.2 5851.2 5977.5 5993.3 6074.8 9675.2 9747.4 9751.3 9774.2 9888.8 9758.8 9932.6 9942.0 10104.3 10107.8 6952.7 7141.6 7147.1 7503.5 7722.1 7985.5 8057.9 8207.9 8306.6 8322.5 7507.2 7594.5 7668.8 7673.3 7677.2 7490.7 7523.1 7660.1 7666.7 7696.1 6556.2 6576.3 6652.2 6661.5 6670.1 5108.6 5109.5 5167.4 5176.6 5253.2 5074.6 5098.5 5099.9 5117.3 5261.3 09:27:08 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | [#4] prototype.html Cycles:180 Average:4800.10 Median:5410.85 stddev:1372.71 (25.4%) stddev-sans-first:1335.56 09:27:08 INFO - PROCESS | 3026 | Values: 363.9 374.5 374.6 378.5 381.4 5213.3 5327.9 5420.3 5461.9 5481.0 5292.3 5347.6 5379.4 5409.7 5412.0 4321.4 4329.0 4332.3 4370.6 4387.4 4242.4 4302.4 4314.4 4316.5 4348.6 4287.5 4297.9 4306.2 4310.3 4323.4 4282.7 4291.3 4297.5 4304.8 4340.8 3733.5 3903.1 3918.2 3922.7 3929.4 5264.6 5271.2 5303.3 5311.9 5313.9 4965.9 4977.6 4980.5 4981.4 4986.2 5444.6 5601.5 5664.8 5736.6 5746.6 4179.0 4184.1 4205.3 4217.2 4227.5 5844.2 5883.7 5887.1 5910.4 5941.6 4200.4 4235.4 4343.2 4351.4 4352.7 4326.6 4414.6 4419.2 4419.4 4420.9 4901.7 4923.6 4933.0 4984.9 5000.0 5579.9 5721.1 5723.4 5730.9 5766.2 1489.7 1493.3 1494.0 1495.4 1500.5 1016.0 1027.6 1035.5 1038.4 1046.2 5337.7 5406.9 5414.8 5434.4 5453.6 5643.9 5660.0 5665.8 5673.5 5690.4 5337.2 5344.4 5344.7 5417.7 5518.1 2995.2 2998.7 3000.5 3002.4 3007.1 5632.7 5867.4 5876.7 5890.3 5965.4 5770.7 5800.9 5800.9 5813.3 5815.0 5863.3 5877.9 5882.4 5886.9 5887.7 5430.8 5533.3 5692.7 5731.1 5820.5 5747.4 5758.0 5761.7 5762.4 5771.0 5879.7 5984.0 6054.6 6113.6 6118.4 3950.9 4055.6 4058.9 4165.8 4186.7 5794.3 5819.5 5819.9 5835.2 5867.9 5568.6 5707.8 5718.5 5720.7 5726.7 5646.9 5682.6 5686.9 5701.7 5704.2 5626.6 5633.6 5643.2 5686.3 5708.9 5517.9 5688.7 5727.9 5731.5 5753.4 5565.9 5594.3 5605.8 5611.6 5617.8 09:27:08 INFO - PROCESS | 3026 | 09:27:08 INFO - PROCESS | 3026 | [#5] yui.html Cycles:180 Average:17873.04 Median:42557.65 stddev:22254.96 (52.3%) stddev-sans-first:22280.10 09:27:08 INFO - PROCESS | 3026 | Values: 716.5 743.2 771.3 852.2 855.2 14798.3 15274.5 15705.1 17221.8 17566.0 15274.5 15411.8 16083.4 16144.3 16189.4 712.2 827.7 835.4 835.8 837.8 726.3 736.0 737.1 803.9 826.0 872.7 877.0 877.6 877.7 877.9 861.4 863.7 863.8 863.9 865.0 545.6 558.9 619.0 637.6 638.6 15826.7 16525.5 16544.4 16550.4 16573.3 14327.0 14432.8 14511.9 14629.1 15442.2 12717.8 12930.5 12936.4 12963.8 13202.0 4024.3 4034.5 4039.9 4078.4 4112.8 84512.0 85357.0 85728.1 86486.0 87587.6 11864.4 11868.8 11882.8 11957.9 12080.9 21759.5 21785.2 22382.8 22686.9 24393.1 9154.2 9176.4 9186.9 9193.4 9257.4 4910.8 4966.6 5031.0 5150.7 5170.3 3707.1 3807.6 3816.3 3816.4 3816.6 634.1 639.9 650.9 651.8 655.3 807.6 811.7 818.5 829.4 839.9 10636.3 10725.4 10762.7 11968.1 11996.9 650.9 683.8 700.0 715.3 717.0 4878.7 5321.9 5359.5 5408.8 5436.0 72827.3 73804.6 75578.0 77102.0 78602.6 55484.4 63516.4 66634.0 67181.0 70796.3 59173.4 62094.0 62665.7 62786.0 63004.0 11063.0 11169.0 11252.5 11297.8 11458.7 42031.2 43084.1 43262.6 43885.3 43919.0 51640.0 52149.0 52312.7 52428.2 52540.2 13665.7 13922.1 13948.2 14008.2 14037.9 14403.9 14458.6 14466.3 14511.0 14558.9 13698.7 13924.4 14200.5 14527.1 14665.4 13039.1 13093.3 13129.1 13167.5 13295.7 13085.1 13202.2 13273.4 13389.3 13546.4 11847.5 11854.9 12067.4 12180.3 12287.1 11248.1 11532.1 11539.6 11617.5 11626.1 09:27:08 INFO - PROCESS | 3026 | -------- Summary: end -------- 09:27:08 INFO - PROCESS | 3026 | 09:27:09 INFO - TEST-INFO | 3026: exit 0 09:27:09 INFO - TEST-OK | dromaeo_css | took 1113846ms 09:27:09 INFO - TEST-START | kraken 09:27:09 INFO - operating with platform_type : linux_ 09:27:09 INFO - Initialising browser for kraken test... 09:27:09 INFO - TEST-INFO | started process 3350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFoaEWw/profile http://localhost:48976/getInfo.html) 09:27:13 INFO - PROCESS | 3350 | __metrics Screen width/height:1600/1200 09:27:13 INFO - PROCESS | 3350 | colorDepth:24 09:27:13 INFO - PROCESS | 3350 | Browser inner width/height: 1024/697 09:27:13 INFO - PROCESS | 3350 | __metrics 09:27:14 INFO - PROCESS | 3350 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:27:14 INFO - PROCESS | 3350 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:27:15 INFO - TEST-INFO | 3350: exit 0 09:27:15 INFO - Browser initialized. 09:27:15 INFO - Running cycle 1/1 for kraken test... 09:27:15 INFO - TEST-INFO | started process 3441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFoaEWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:27 INFO - PROCESS | 3441 | RSS: Main: 137822208 09:27:27 INFO - PROCESS | 3441 | 09:27:29 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48976/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:30 INFO - PROCESS | 3441 | RSS: Main: 181469184 09:27:30 INFO - PROCESS | 3441 | 09:27:32 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48976/tests/kraken/driver.html?testName=audio-dft) 09:27:33 INFO - PROCESS | 3441 | RSS: Main: 172548096 09:27:33 INFO - PROCESS | 3441 | 09:27:36 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48976/tests/kraken/driver.html?testName=audio-fft) 09:27:36 INFO - PROCESS | 3441 | RSS: Main: 263507968 09:27:36 INFO - PROCESS | 3441 | 09:27:38 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48976/tests/kraken/driver.html?testName=audio-oscillator) 09:27:39 INFO - PROCESS | 3441 | RSS: Main: 169521152 09:27:39 INFO - PROCESS | 3441 | 09:27:41 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:42 INFO - PROCESS | 3441 | RSS: Main: 172097536 09:27:42 INFO - PROCESS | 3441 | 09:27:45 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48976/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:45 INFO - PROCESS | 3441 | RSS: Main: 210374656 09:27:45 INFO - PROCESS | 3441 | 09:27:49 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48976/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:49 INFO - PROCESS | 3441 | RSS: Main: 209145856 09:27:49 INFO - PROCESS | 3441 | 09:27:52 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48976/tests/kraken/driver.html?testName=json-parse-financial) 09:27:53 INFO - PROCESS | 3441 | RSS: Main: 207859712 09:27:53 INFO - PROCESS | 3441 | 09:27:54 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:55 INFO - PROCESS | 3441 | RSS: Main: 170332160 09:27:55 INFO - PROCESS | 3441 | 09:27:56 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48976/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:57 INFO - PROCESS | 3441 | RSS: Main: 177254400 09:27:57 INFO - PROCESS | 3441 | 09:27:59 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:28:00 INFO - PROCESS | 3441 | RSS: Main: 187011072 09:28:00 INFO - PROCESS | 3441 | 09:28:02 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:03 INFO - PROCESS | 3441 | RSS: Main: 196562944 09:28:03 INFO - PROCESS | 3441 | 09:28:06 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:06 INFO - PROCESS | 3441 | RSS: Main: 191631360 09:28:06 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:48976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48976/tests/kraken/driver.html?testName=ai-astar) 09:28:08 INFO - PROCESS | 3441 | RSS: Main: 244404224 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | __start_tp_report 09:28:08 INFO - PROCESS | 3441 | _x_x_mozilla_page_load 09:28:08 INFO - PROCESS | 3441 | _x_x_mozilla_page_load_details 09:28:08 INFO - PROCESS | 3441 | |i|pagename|runs| 09:28:08 INFO - PROCESS | 3441 | |0;ai-astar;111;112;114;112;112;111;111;110;111;112 09:28:08 INFO - PROCESS | 3441 | |1;audio-beat-detection;142;117;118;151;118;118;117;117;138;123 09:28:08 INFO - PROCESS | 3441 | |2;audio-dft;160;161;160;161;159;161;161;162;160;160 09:28:08 INFO - PROCESS | 3441 | |3;audio-fft;76;77;76;105;77;78;77;77;91;76 09:28:08 INFO - PROCESS | 3441 | |4;audio-oscillator;83;82;107;82;82;82;92;82;81;100 09:28:08 INFO - PROCESS | 3441 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 09:28:08 INFO - PROCESS | 3441 | |6;imaging-darkroom;145;147;146;147;145;146;145;147;147;146 09:28:08 INFO - PROCESS | 3441 | |7;imaging-desaturate;97;96;96;96;96;95;95;95;96;95 09:28:08 INFO - PROCESS | 3441 | |8;json-parse-financial;48;48;49;48;48;47;48;48;48;48 09:28:08 INFO - PROCESS | 3441 | |9;json-stringify-tinderbox;63;63;63;63;64;63;62;63;64;63 09:28:08 INFO - PROCESS | 3441 | |10;stanford-crypto-aes;77;83;75;77;84;74;75;75;76;76 09:28:08 INFO - PROCESS | 3441 | |11;stanford-crypto-ccm;121;122;130;125;129;119;130;120;162;123 09:28:08 INFO - PROCESS | 3441 | |12;stanford-crypto-pbkdf2;165;157;164;156;160;157;161;157;161;156 09:28:08 INFO - PROCESS | 3441 | |13;stanford-crypto-sha256-iterative;61;60;62;60;61;59;60;60;59;59 09:28:08 INFO - PROCESS | 3441 | __end_tp_report 09:28:08 INFO - PROCESS | 3441 | __start_cc_report 09:28:08 INFO - PROCESS | 3441 | _x_x_mozilla_cycle_collect,1516 09:28:08 INFO - PROCESS | 3441 | __end_cc_report 09:28:08 INFO - PROCESS | 3441 | __startTimestamp1487957288529__endTimestamp 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | ------- Summary: start ------- 09:28:08 INFO - PROCESS | 3441 | Number of tests: 14 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.07 (1.0%) stddev-sans-first:1.12 09:28:08 INFO - PROCESS | 3441 | Values: 111.0 112.0 114.0 112.0 112.0 111.0 111.0 110.0 111.0 112.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:120.50 stddev:12.78 (10.6%) stddev-sans-first:12.15 09:28:08 INFO - PROCESS | 3441 | Values: 142.0 117.0 118.0 151.0 118.0 118.0 117.0 117.0 138.0 123.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 09:28:08 INFO - PROCESS | 3441 | Values: 160.0 161.0 160.0 161.0 159.0 161.0 161.0 162.0 160.0 160.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#3] audio-fft Cycles:10 Average:81.00 Median:77.00 stddev:9.57 (12.4%) stddev-sans-first:9.98 09:28:08 INFO - PROCESS | 3441 | Values: 76.0 77.0 76.0 105.0 77.0 78.0 77.0 77.0 91.0 76.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:82.00 stddev:9.25 (11.3%) stddev-sans-first:9.68 09:28:08 INFO - PROCESS | 3441 | Values: 83.0 82.0 107.0 82.0 82.0 82.0 92.0 82.0 81.0 100.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:28:08 INFO - PROCESS | 3441 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 09:28:08 INFO - PROCESS | 3441 | Values: 145.0 147.0 146.0 147.0 145.0 146.0 145.0 147.0 147.0 146.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.53 09:28:08 INFO - PROCESS | 3441 | Values: 97.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.00 stddev:0.47 (1.0%) stddev-sans-first:0.50 09:28:08 INFO - PROCESS | 3441 | Values: 48.0 48.0 49.0 48.0 48.0 47.0 48.0 48.0 48.0 48.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:28:08 INFO - PROCESS | 3441 | Values: 63.0 63.0 63.0 63.0 64.0 63.0 62.0 63.0 64.0 63.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.50 stddev:3.46 (4.5%) stddev-sans-first:3.67 09:28:08 INFO - PROCESS | 3441 | Values: 77.0 83.0 75.0 77.0 84.0 74.0 75.0 75.0 76.0 76.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:127.00 stddev:12.60 (9.9%) stddev-sans-first:13.10 09:28:08 INFO - PROCESS | 3441 | Values: 121.0 122.0 130.0 125.0 129.0 119.0 130.0 120.0 162.0 123.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:160.50 stddev:3.31 (2.1%) stddev-sans-first:2.82 09:28:08 INFO - PROCESS | 3441 | Values: 165.0 157.0 164.0 156.0 160.0 157.0 161.0 157.0 161.0 156.0 09:28:08 INFO - PROCESS | 3441 | 09:28:08 INFO - PROCESS | 3441 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.00 stddev:0.99 (1.7%) stddev-sans-first:1.00 09:28:08 INFO - PROCESS | 3441 | Values: 61.0 60.0 62.0 60.0 61.0 59.0 60.0 60.0 59.0 59.0 09:28:08 INFO - PROCESS | 3441 | -------- Summary: end -------- 09:28:08 INFO - PROCESS | 3441 | 09:28:09 INFO - TEST-INFO | 3441: exit 0 09:28:09 INFO - TEST-OK | kraken | took 60085ms 09:28:09 INFO - SUITE-END | took 1173s 09:28:09 INFO - Completed test suite (00:19:34) 09:28:09 INFO - javascript benchmark 09:28:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.3727391795555, 3323.800571965684, 3334.9166270843234, 3362.058623585394, 3375.0, 5421.9457805421935, 5470.91793623096, 5484.972575137123, 5492.560595152383, 5513.696746678931, 5515.817196899404, 5563.610547261694, 5571.470710282517, 5579.38626751057, 5599.804006859761, 5055.039542486925, 5072.3405957225505, 5103.311053007852, 5105.336306280197, 5187.8443646690475, 4932.827351042714, 5109.69341839489, 5162.870928226786, 5166.535011848933, 5170.560502357304, 4935.605151587883, 5052.989402119572, 5084.567811736007, 5113.386393632751, 5188.896222075557, 5126.179811230204, 5159.303494028296, 5161.406438259611, 5165.586753059746, 5166.121759300928, 5001.824936127255, 5064.9746751266375, 5112.514311140436, 5117.8464646060675, 5151.5621172200035, 5340.25236466895, 5367.758450869681, 5407.972960135174, 5408.45915408456, 5483.122700367922, 5938.584299099065, 5972.432618901241, 5978.342382337939, 5978.581499295051, 6000.729967151488, 5957.791477298274, 5991.730372133221, 5999.790007349722, 6015.398460153993, 6021.5182785377065, 5475.479829416199, 5477.67133971963, 5482.835514934558, 5505.559555235572, 5640.520555752766, 6062.393760623902, 6064.36324185963, 6091.08633704939, 6094.268687757498, 6095.177151084636, 5787.1319302104175, 5840.415958404211, 5848.619839710405, 5850.882982340329, 5854.941450585439, 5755.251817263729, 5794.768209271666, 5928.0515117581845, 5928.288605367297, 5932.466078052996, 5759.0, 5862.0, 5887.175795388649, 5945.346011938684, 5966.134910437962, 5957.2255606771705, 5960.433758792908, 5965.910511342333, 5967.16459695643, 5970.9701451492465, 4483.3723278741, 4617.561331673485, 4623.352730617717, 4629.837955671535, 4653.674242802971, 4035.6771458283265, 4050.1697152083752, 4071.42999980003, 4096.856610018635, 4154.169166166718, 5802.448767367094, 5803.564732645069, 5804.506616937523, 5805.535557155417, 5806.941930580725, 5748.338941021836, 5803.622764520293, 5861.296644402613, 5990.760369585168, 5992.221011268594, 5674.432556744293, 5766.077427611646, 5769.07694768835, 5782.10377391505, 5804.564657650693, 5057.69653820772, 5062.924056139161, 5067.037262920034, 5076.7207803571155, 5079.6698214615935, 6034.48706859913, 6070.3019152798, 6125.418085281891, 6170.660613666291, 6233.594816337014, 5779.566532510163, 5811.79658711943, 5846.766129354778, 5913.822585322448, 5955.344912059583, 6109.908351374822, 6161.075838624242, 6167.044108163242, 6169.352218017223, 6170.845728856814, 5680.971595141998, 5833.095870140135, 5833.883322333445, 5837.445442682938, 5838.2702162229725, 5776.537876969748, 5838.241028666416, 5841.678707671119, 5886.264216972879, 5991.0, 5763.308402991668, 5815.534757219497, 5822.854428639149, 5823.039198532364, 5827.388124246893, 5804.912926306193, 5817.621854579439, 5825.213596164633, 5830.038043722739, 5830.18377427169, 5582.553395728413, 5588.189712491747, 5591.748371323219, 5639.041362968387, 5639.492445679908, 5723.0, 5753.482186603226, 5761.942380576308, 5772.942270577409, 5776.451237132465, 5628.85927851807, 5637.182608521824, 5646.322441307069, 5651.8304450866535, 5665.065264231355], "value": 5479.916603149229, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.5072209650266, 614.3672017821644, 616.198941376211, 648.354886887547, 656.6880731652466, 39005.80497097514, 47749.0, 48261.75869120658, 48326.033479330436, 51882.48117518824, 50181.24728129072, 50503.24245136326, 50540.494595054035, 50571.49428505723, 50694.0, 8764.56177191141, 8951.104889511062, 9378.718638440841, 9564.80870382592, 9569.904300957005, 10994.34033957961, 11297.548098076068, 11304.321740695543, 11679.182457227955, 11694.532218711242, 11325.830112548318, 11399.316041037522, 11407.25852819564, 11408.71478213043, 11415.714607134805, 11164.162687798407, 11191.552337906474, 11200.607978720787, 11208.887911120866, 11269.887301127048, 11080.113590912708, 11177.66467005991, 11179.441027948651, 11189.160812939062, 11190.496427660775, 47121.528784712056, 47137.0, 47435.52564474346, 47542.0, 47587.286190707164, 4294.26997410441, 4381.956180438218, 4460.643148548108, 4537.478190008125, 4548.795304211319, 33642.49536256958, 33750.83124584386, 33817.154571135674, 34165.65834341649, 35711.4643280351, 4514.6614003949835, 4562.087582483517, 4598.333241679971, 4602.424696912886, 4628.907421851578, 351057.0, 351856.0, 352935.0, 353232.0, 353317.23341383383, 65915.34084659188, 66009.0, 66128.33871661319, 66830.0, 66873.33126668769, 71652.0, 71657.0, 71781.2821871785, 71845.64077179685, 71919.64040179871, 19518.902405488167, 20055.59888802216, 20067.698984515246, 20077.0, 20089.497762556053, 13694.246816424993, 13889.583312500641, 15181.392744290326, 15561.221938903009, 15656.765148522782, 18919.0, 19303.710444343345, 19335.8066419334, 19348.32280870163, 19374.0, 7004.544704594185, 7130.25132361105, 7130.358267755927, 7294.562326260335, 7295.161056478573, 974.3228456222857, 975.1272611013104, 981.9656312029188, 994.9900500995042, 1001.7245257554231, 32765.836170818995, 33365.499517507254, 33649.83175084109, 33825.661743382254, 33899.491507627405, 1100.1528822806395, 1161.976760464786, 1171.3499008050615, 1192.9463174157183, 1195.6831439668495, 17696.734548981774, 17841.197146128456, 17969.910150449163, 17980.190891409657, 18011.819881801275, 495983.0, 498459.0, 498661.0, 500871.0, 505228.0, 65913.0, 66265.33734662688, 66656.33343666501, 66668.33331666718, 66690.33309666938, 1534.8465153484563, 1543.7221300165854, 1569.4977607165597, 1582.2247098921675, 1600.9359625614845, 31176.844115780183, 32696.836515817267, 32844.50733239051, 32959.67040329566, 33581.0, 56618.0, 57246.0, 57246.42753572411, 57246.713766430905, 57293.999999998334, 394221.0, 394850.0, 395034.0, 396072.0, 396099.0, 38073.619263807006, 43402.0, 44039.77980110079, 44318.556814431446, 47519.524804752895, 50666.493335066174, 51256.74371628267, 51325.0, 51502.0, 51570.0, 42091.0, 43902.0, 44045.79771011501, 44674.10651787011, 45644.315335270665, 42211.577884220766, 42548.149037019706, 42923.35614965841, 44442.77778611216, 44575.33137003012, 42138.0, 42492.0, 43065.569344306154, 43696.34455483107, 43794.0, 36273.63726362808, 37811.243775123796, 38235.0, 38768.22463550769, 38920.80539597284, 27979.160625181277, 28160.85919570389, 28241.71758282473, 28244.293892652848, 28472.0], "value": 22120.194750119594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.12320702472135, 409.3532219093832, 416.93120635095204, 418.6002367738811, 432.63442391179444, 20083.899580502097, 20322.381151874222, 21380.037898294577, 21752.782472175273, 21811.67282490762, 21520.246791362304, 21894.89052554739, 22450.55098898021, 22571.0, 22743.31770046897, 5974.910376344358, 6167.321594624587, 6201.472874805624, 6208.161898143738, 6209.596376235553, 5906.084556893667, 6015.3383127855905, 6027.608205466652, 6102.298235702907, 6105.389461053904, 6065.545084118687, 6076.787312444066, 6081.54388420868, 6082.787102451415, 6084.056971169476, 5874.089516124986, 5984.5212383009475, 6018.127371531147, 6028.1861948636815, 6028.4272994065495, 5286.392064912546, 5330.067238233293, 5411.729413529308, 5416.187571864252, 5424.294841670558, 25403.745962540506, 25611.0, 25647.974081036737, 25724.87137564319, 25863.0, 2793.1620513845764, 3018.622672165979, 3023.425549145655, 3048.481758101128, 3051.343961048363, 15013.849861501354, 15689.607759805982, 15734.842651573452, 15737.213139342986, 15778.76331855023, 1954.1304119666754, 1983.3256692724399, 2002.8497862660358, 2006.17746723844, 2008.9497762556052, 96681.0, 98993.50503247509, 100019.0, 100700.49649751777, 102396.0, 12038.277703337828, 12163.0, 12172.391380430943, 12181.269123852597, 12239.632811015685, 17400.303987840343, 17431.12844357777, 17433.21550530229, 17450.0, 17475.650486990442, 9019.909800901907, 9132.452052876848, 9173.633054677872, 9231.353805233703, 9372.0, 8796.516191609522, 8854.734357969272, 8894.332925030649, 9062.954685226532, 9131.589078491485, 5143.7685304161405, 5186.688798672017, 5200.531952124327, 5252.5535329497425, 5340.465953404629, 2033.3188381891937, 2093.204582258732, 2128.6274901892416, 2131.296672098204, 2135.8214621086404, 941.8445956417114, 947.5830634520789, 966.8984756600596, 967.67099186277, 968.1141755293968, 19009.714854277197, 20769.48825683585, 20881.37355879326, 20992.685109723367, 21045.579088418144, 956.220680145693, 966.1256562810668, 968.3173362779364, 976.1019861727086, 977.1010670183448, 10820.78358432827, 11595.246308989888, 11624.593139240085, 11631.53473861053, 11710.94144529272, 676639.0, 693071.0, 705061.0, 717108.0, 721434.0, 66388.0, 86030.56984715162, 102482.0, 108946.45526772315, 112680.0, 1066.36018388966, 1070.71626019105, 1107.5293000474767, 1112.67732357617, 1114.4817659788237, 18333.3583324583, 18873.339433119774, 18894.433167005012, 19086.809131908503, 19335.903320483307, 42446.0, 42866.78566607147, 45931.77034114808, 46181.76909115567, 46298.768506157256, 62503.6874815623, 62949.37050629435, 63051.684741576, 63311.36688633055, 63578.68210658917, 9264.861027084735, 9374.812503750023, 9439.150476456876, 9526.142647161789, 9713.9028609713, 8626.870596941177, 9811.474554283732, 12614.36928153607, 13131.474741010252, 14075.366608502847, 7461.0, 11196.66410007701, 12170.330631815335, 12269.69325766863, 12574.0, 5894.911576326444, 10184.0, 11971.683114857533, 11991.280523168638, 12524.373781310716, 12270.81593776112, 12674.683132921382, 12810.871891280967, 12994.220346779224, 13043.152195107288, 9407.85888211691, 9454.905450945402, 9571.904280957102, 9587.137157655845, 9628.422294662343, 9525.476098814632, 12374.505019799108, 12502.0, 12508.749825003268, 12539.0], "value": 10009.02425578978, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.777133429986, 1508.969820603588, 1520.3234560620524, 1529.5411376587024, 1547.8452154784516, 8208.876866847002, 8734.606942687578, 8745.562721863913, 8755.036945935943, 8828.337874659393, 7761.146273909865, 7966.004249468817, 8452.323814094872, 8662.047174810767, 8708.651653933835, 2336.7079115110655, 2374.00291877411, 2374.1097088591778, 2378.8096952243777, 2381.8094552435764, 2421.3462365161395, 2443.755624437551, 2451.3258853815164, 2453.3989172652723, 2455.58255096634, 2335.427820184049, 2362.70466191726, 2368.7039120109985, 2377.785999260066, 2396.317049640853, 2309.549637820626, 2317.826163037762, 2330.4406942333885, 2344.1678204237505, 2379.298107058422, 2316.6872472216373, 2319.605667036591, 2336.7780060894356, 2345.4370950971816, 2345.5308938212424, 8557.400981931267, 8685.392022558424, 8698.260647844942, 8705.434146780439, 8724.34567407447, 5297.258383826267, 5440.483154100354, 5446.645968012106, 5452.536534394581, 5454.61817672763, 3391.2030672791875, 3392.1858753899132, 3446.6208717041104, 3465.5668041494814, 3488.3197776433353, 1312.3110367057275, 1349.5074297881301, 1392.220356600307, 1398.7971744097151, 1462.6489642485833, 11810.822837657443, 11933.34366609836, 11945.940270298679, 11959.940200298943, 11967.880321196852, 4588.678792484561, 4791.712497250176, 4821.927671084936, 4831.106245344622, 4831.51684831514, 10419.687409377731, 10436.947815261026, 10442.112420444195, 10443.738906527398, 10449.111825494767, 5472.91790623141, 5491.258680078218, 5506.504414602705, 5511.807086751945, 5515.751791169407, 4228.70399072062, 4806.591439727662, 4854.781534830941, 4872.342233798392, 4931.5315045070665, 4096.603486960162, 4144.958550414518, 4183.372494125905, 4219.662427005894, 4224.134052519226, 1285.6693322411447, 1292.8707129286995, 1304.0284987684236, 1304.4847285322244, 1306.046585992231, 852.6589364254348, 897.4166791585391, 921.7787730944525, 939.6335429182624, 969.2052516936045, 5908.438698323653, 5922.911156332659, 5931.73307201177, 5950.464458198696, 6308.558400911892, 1032.9773524211128, 1050.238577031646, 1069.6256310291335, 1087.9020888119949, 1117.3910218930703, 3943.881683549441, 3946.5264168299414, 4079.265732168179, 4150.584941505886, 4170.52039015511, 10406.947965260277, 10767.246292759588, 10768.3538987661, 10771.676849694522, 10774.892251077388, 10685.679429617125, 10707.946460267805, 10719.78560428787, 10730.73173170677, 10734.73163170927, 7872.763817085496, 8245.628946697292, 8249.670013199524, 8368.37237207212, 8582.485050896841, 5818.214541037075, 5851.151583020353, 5977.535503801597, 5993.280806303272, 6074.848128796639, 9675.22598192157, 9747.415155090717, 9751.268654850772, 9774.169195618451, 9888.802223955625, 9758.756031098996, 9932.602695892372, 9941.950290248502, 10104.343217691121, 10107.848382274125, 6952.7137479566445, 7141.64291785419, 7147.106611673541, 7503.474756766974, 7722.073351197892, 7985.480943738638, 8057.879131813144, 8207.917920820953, 8306.626201821053, 8322.54226017575, 7507.249275072449, 7594.5063570869925, 7668.846623067396, 7673.309402153833, 7677.193894640982, 7490.662920168496, 7523.059617547807, 7660.119086304923, 7666.693332266647, 7696.114946781192, 6556.246031706415, 6576.2766095730385, 6652.234992975869, 6661.533692641468, 6670.066190733204, 5108.56577190943, 5109.514596113363, 5167.379914410295, 5176.637635365639, 5253.212018197301, 5074.619403544675, 5098.515641014098, 5099.872503187302, 5117.257997590403, 5261.342332208474], "value": 4667.420338443421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.93994990826513, 374.4701247734456, 374.6384738727128, 378.54763557548733, 381.3973921204497, 5213.270142180088, 5327.893442131165, 5420.295361602991, 5461.9453805461935, 5481.040817856879, 5292.311999440068, 5347.609621498409, 5379.408265090837, 5409.702466364358, 5411.998780225661, 4321.351797230409, 4329.0, 4332.3284890841815, 4370.628496577795, 4387.429634147572, 4242.448481697375, 4302.354646802989, 4314.417553630266, 4316.460442444694, 4348.630366418858, 4287.5498072702385, 4297.892552686192, 4306.224879521685, 4310.310350343945, 4323.437953066113, 4282.657387409015, 4291.291936830419, 4297.484301883794, 4304.806283717225, 4340.782960851945, 3733.45864849598, 3903.1217975955183, 3918.1771827916173, 3922.7057970652313, 3929.4302326162833, 5264.578833693296, 5271.209318602202, 5303.257543943851, 5311.867203319909, 5313.867153321198, 4965.889496963776, 4977.626677999165, 4980.452150263468, 4981.352424184869, 4986.177280748672, 5444.5916556258435, 5601.467860553241, 5664.830055098354, 5736.565858535366, 5746.569007324468, 4178.979105104455, 4184.14225083857, 4205.285101532747, 4217.177650358181, 4227.471566054243, 5844.240248767675, 5883.676397798119, 5887.087501437284, 5910.438508341744, 5941.55438342126, 4200.4053635792125, 4235.385869048971, 4343.218220720238, 4351.43431353922, 4352.69531132824, 4326.567343265649, 4414.646828253732, 4419.160359531678, 4419.40338054365, 4420.8673739787855, 4901.681390709592, 4923.630727695438, 4932.988737308843, 4984.925226121611, 4999.950000500021, 5579.860503487364, 5721.141828725725, 5723.370429252779, 5730.856728581819, 5766.185235328548, 1489.7318482673006, 1493.3429291111877, 1494.0, 1495.3719437836135, 1500.4545318322146, 1015.962994196631, 1027.6403258859489, 1035.5443604813859, 1038.4081073787868, 1046.1630695443614, 5337.653052551572, 5406.8918621627345, 5414.752877555849, 5434.402215756264, 5453.618246722692, 5643.887122257532, 5659.971700141473, 5665.773369065191, 5673.461021202979, 5690.374058853523, 5337.238711225286, 5344.35867695879, 5344.679319240858, 5417.729113544386, 5518.089515229942, 2995.1912983494335, 2998.7001299870276, 3000.4599172149224, 3002.3995200959457, 3007.0978706387996, 5632.690202038845, 5867.442592953748, 5876.7355469004, 5890.293164820249, 5965.403459654, 5770.672745268528, 5800.883982320414, 5800.941990580124, 5813.331466881278, 5815.022892216667, 5863.2670916135485, 5877.853053673607, 5882.411758824083, 5886.911696324559, 5887.676177810176, 5430.755615997368, 5533.320341972543, 5692.658440493584, 5731.111677689964, 5820.489120931312, 5747.4252574742195, 5757.971210143923, 5761.683107429131, 5762.366139724711, 5771.0, 5879.7060146993335, 5984.0, 6054.576179667381, 6113.633182009094, 6118.388161184024, 3950.9209815804097, 4055.574164712663, 4058.918821623492, 4165.812538435717, 4186.706930514834, 5794.275715535558, 5819.476247137778, 5819.854503637443, 5835.183074369506, 5867.885101830639, 5568.605499635196, 5707.828765137053, 5718.456746609066, 5720.656760594377, 5726.656400615976, 5646.943530564642, 5682.6306290091015, 5686.947914635805, 5701.686407247641, 5704.201411802268, 5626.606137570331, 5633.633813802254, 5643.181738647955, 5686.34607020198, 5708.942910570841, 5517.917231241454, 5688.687122208153, 5727.942720572741, 5731.484166425042, 5753.367129615655, 5565.886822635408, 5594.3286805581965, 5605.831825045255, 5611.607187496999, 5617.764091899776], "value": 4374.99384251942, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.5449939288553, 743.1602289412963, 771.3019717155972, 852.1946760311504, 855.2345650642677, 14798.260086995648, 15274.465393711236, 15705.136217508047, 17221.82778172218, 17566.0, 15274.541763747106, 15411.768823467657, 16083.437079702213, 16144.273507692153, 16189.433369832059, 712.2343480758179, 827.6523859978823, 835.3859912963967, 835.7743409279491, 837.844998675244, 726.2519604807057, 735.9926400736005, 737.074970911508, 803.895493585836, 826.0335407573124, 872.7294538693026, 876.9693060742875, 877.6401675313123, 877.7279043496504, 877.9253763430116, 861.3884142258972, 863.7322430046643, 863.7754183912197, 863.9481631102091, 865.0398058155442, 545.6262460214726, 558.8882223555305, 619.0373968479013, 637.6078711592384, 638.5753473939825, 15826.683466330724, 16525.504234872973, 16544.42094526686, 16550.42073527433, 16573.337066517324, 14327.0, 14432.783508247385, 14511.927440362837, 14629.122252664767, 15442.227888605637, 12717.809232861515, 12930.547430839875, 12936.417861196269, 12963.805542916863, 13202.009849261343, 4024.2957482440456, 4034.536028356747, 4039.8788036358956, 4078.449409329732, 4112.753234805921, 84512.0, 85357.0, 85728.14271857326, 86486.0, 87587.56206218927, 11864.406779660982, 11868.762624747456, 11882.821757673642, 11957.880421195676, 12080.879191207976, 21759.45601359947, 21785.23751668684, 22382.776172238067, 22686.886565567067, 24393.14623988152, 9154.176124148858, 9176.44941303524, 9186.908130918739, 9193.448393096436, 9257.444553326823, 4910.8281210157475, 4966.553010229097, 5031.018951304533, 5150.742462876841, 5170.250313704491, 3707.0917625182, 3807.5811660717854, 3816.3321418751607, 3816.3893776995546, 3816.637419445148, 634.0995785983914, 639.9200099987502, 650.905618685288, 651.7751375775445, 655.2791928878196, 807.6325272001226, 811.7443005453264, 818.5048045932244, 829.4401279136558, 839.9328053755685, 10636.255462117731, 10725.410102444284, 10762.677119686421, 11968.10239232061, 11996.880031199751, 650.8568115014689, 683.8392977650249, 699.9860002800017, 715.3025799845109, 716.9820754481179, 4878.658493905464, 5321.86695332612, 5359.490848369399, 5408.810691625774, 5436.0, 72827.2717272831, 73804.63097684477, 75578.0, 77102.0, 78602.60698696584, 55484.44515554873, 63516.36483635197, 66634.0, 67181.0, 70796.29203708, 59173.40826591765, 62094.0, 62665.68667156635, 62786.0, 63004.0, 11063.0, 11169.0, 11252.468194656465, 11297.774044519228, 11458.713532161762, 42031.15937681168, 43084.13831723285, 43262.56737432711, 43885.34171987359, 43919.0, 51640.0, 52149.0, 52312.738436307576, 52428.21357679561, 52540.211896822344, 13665.658358541115, 13922.09506382082, 13948.232847193502, 14008.229547374993, 14037.859621403655, 14403.855961440251, 14458.566243012727, 14466.27668616544, 14511.0, 14558.927205363905, 13698.657533561342, 13924.443022278996, 14200.502982395567, 14527.128372297273, 14665.413383464542, 13039.087263891815, 13093.279869607262, 13129.146605470614, 13167.53913613019, 13295.66760830987, 13085.08404411682, 13202.207867527979, 13273.402696878471, 13389.263590502616, 13546.390412431661, 11847.526098955945, 11854.881451185378, 12067.396630168281, 12180.33008184523, 12287.1399002069, 11248.100151987657, 11532.135089868125, 11539.596114135966, 11617.477213525242, 11626.069914406997], "value": 7515.796253134204, "unit": "score"}], "name": "dromaeo_css", "value": 7556.811501855028, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 114.0, 112.0, 112.0, 111.0, 111.0, 110.0, 111.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 118.0, 151.0, 118.0, 118.0, 117.0, 117.0, 138.0, 123.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 159.0, 161.0, 161.0, 162.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 105.0, 77.0, 78.0, 77.0, 77.0, 91.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 107.0, 82.0, 82.0, 82.0, 92.0, 82.0, 81.0, 100.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 147.0, 145.0, 146.0, 145.0, 147.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 48.0, 48.0, 47.0, 48.0, 48.0, 48.0, 48.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 64.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 75.0, 77.0, 84.0, 74.0, 75.0, 75.0, 76.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 130.0, 125.0, 129.0, 119.0, 130.0, 120.0, 162.0, 123.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 157.0, 164.0, 156.0, 160.0, 157.0, 161.0, 157.0, 161.0, 156.0], "value": 159.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 60.0, 61.0, 59.0, 60.0, 60.0, 59.0, 59.0], "value": 60.1, "unit": "score"}], "name": "kraken", "value": 1460.8, "alertThreshold": 2.0}]} 09:28:09 INFO - Return code: 0 09:28:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:28:09 ERROR - # TBPL SUCCESS # 09:28:09 INFO - Running post-action listener: _resource_record_post_action 09:28:09 INFO - [mozharness: 2017-02-24 17:28:09.823477Z] Finished run-tests step (success) 09:28:09 INFO - Running post-run listener: _resource_record_post_run 09:28:09 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 364457984; Read time: 0; Write time: 234488 09:28:09 INFO - TinderboxPrint: CPU usage
13.0% 09:28:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:28:09 INFO - TinderboxPrint: I/O write bytes / time
364,457,984 / 234,488 09:28:09 INFO - TinderboxPrint: CPU idle
8,268.7 (87.0%) 09:28:09 INFO - TinderboxPrint: CPU user
1,191.4 (12.5%) 09:28:09 INFO - TinderboxPrint: Swap in / out
0 / 0 09:28:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109993984; Read time: 0; Write time: 87704 09:28:09 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 254464000; Read time: 0; Write time: 146784 09:28:10 INFO - Running post-run listener: _upload_blobber_files 09:28:10 INFO - Blob upload gear active. 09:28:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:28:10 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 09:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:28:10 INFO - (blobuploader) - INFO - Open directory for files ... 09:28:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:28:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:28:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:14 INFO - (blobuploader) - INFO - Done attempting. 09:28:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:28:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:28:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:15 INFO - (blobuploader) - INFO - Done attempting. 09:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:16 INFO - (blobuploader) - INFO - Done attempting. 09:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:16 INFO - (blobuploader) - INFO - Done attempting. 09:28:16 INFO - (blobuploader) - INFO - Iteration through files over. 09:28:16 INFO - Return code: 0 09:28:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:28:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:28:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/279a260abd6a36e15edb698cc8ea136cbb1f71f0cdaa4f515aab86677a5dfbc99d357d5c61c5308c05a4f75ed27f8d9a2d53604262ac6467abae7bee085232a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bc78d1ac5e8eb0133aadcf93fba7b39058d3b7113796fdb3c8f43449a3cf5cae522e67c7129dacdf5541eb87d1444345aee84309d28b9d33d3d5ec1272a0ccc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2be963ff7f6abcbaf91c11c9ddc5baf7f274b4b4fdbe378d6525208e50a20bcce1e0a12deff9132164eed25feaa72d7d77b762d68680575a535af1b2cf8d1541", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3f7472296dda58e4663fbf095fd1d00860726d3127b670efa977ca8a62601ea53a96b47315f5e7a1c5d9a9b12ea9dbae2283c6f5a379c1ed2ea3f5962fac14"} 09:28:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:28:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:28:16 INFO - Contents: 09:28:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/279a260abd6a36e15edb698cc8ea136cbb1f71f0cdaa4f515aab86677a5dfbc99d357d5c61c5308c05a4f75ed27f8d9a2d53604262ac6467abae7bee085232a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bc78d1ac5e8eb0133aadcf93fba7b39058d3b7113796fdb3c8f43449a3cf5cae522e67c7129dacdf5541eb87d1444345aee84309d28b9d33d3d5ec1272a0ccc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2be963ff7f6abcbaf91c11c9ddc5baf7f274b4b4fdbe378d6525208e50a20bcce1e0a12deff9132164eed25feaa72d7d77b762d68680575a535af1b2cf8d1541", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3f7472296dda58e4663fbf095fd1d00860726d3127b670efa977ca8a62601ea53a96b47315f5e7a1c5d9a9b12ea9dbae2283c6f5a379c1ed2ea3f5962fac14"} 09:28:16 INFO - Running post-run listener: copy_logs_to_upload_dir 09:28:16 INFO - Copying logs to upload dir... 09:28:16 INFO - mkdir: /builds/slave/test/build/upload/logs 09:28:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.920976 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-02-24 09:28:16.671822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 09:28:16.675290) ========= 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=3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/279a260abd6a36e15edb698cc8ea136cbb1f71f0cdaa4f515aab86677a5dfbc99d357d5c61c5308c05a4f75ed27f8d9a2d53604262ac6467abae7bee085232a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bc78d1ac5e8eb0133aadcf93fba7b39058d3b7113796fdb3c8f43449a3cf5cae522e67c7129dacdf5541eb87d1444345aee84309d28b9d33d3d5ec1272a0ccc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2be963ff7f6abcbaf91c11c9ddc5baf7f274b4b4fdbe378d6525208e50a20bcce1e0a12deff9132164eed25feaa72d7d77b762d68680575a535af1b2cf8d1541", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3f7472296dda58e4663fbf095fd1d00860726d3127b670efa977ca8a62601ea53a96b47315f5e7a1c5d9a9b12ea9dbae2283c6f5a379c1ed2ea3f5962fac14"} build_url:https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/M4WFLnrZSEigZuaIJJll8w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/279a260abd6a36e15edb698cc8ea136cbb1f71f0cdaa4f515aab86677a5dfbc99d357d5c61c5308c05a4f75ed27f8d9a2d53604262ac6467abae7bee085232a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bc78d1ac5e8eb0133aadcf93fba7b39058d3b7113796fdb3c8f43449a3cf5cae522e67c7129dacdf5541eb87d1444345aee84309d28b9d33d3d5ec1272a0ccc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2be963ff7f6abcbaf91c11c9ddc5baf7f274b4b4fdbe378d6525208e50a20bcce1e0a12deff9132164eed25feaa72d7d77b762d68680575a535af1b2cf8d1541", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3f7472296dda58e4663fbf095fd1d00860726d3127b670efa977ca8a62601ea53a96b47315f5e7a1c5d9a9b12ea9dbae2283c6f5a379c1ed2ea3f5962fac14"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 09:28:16.704997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:28:16.705600) ========= 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=3836458cccd887f2d2de3cf1000001de-1487955810.669898-937725699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 09:28:16.791329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 09:28:16.791881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 09:28:16.792403) ========= ========= Total master_lag: 0.19 =========